====================================== | [ 761.713461] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 761.716183] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 761.870093] kselftest: Running tests in drivers/net [ 989.677621] INFO: task python3:5409 blocked for more than 122 seconds. [ 989.685839] Not tainted 7.1.0-rc6-ambq-g68fe9b8005df #1 [ 989.693636] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.703228] task:python3 state:D stack:25672 pid:5409 tgid:5409 ppid:5408 task_flags:0x400100 flags:0x00080000 [ 989.716434] Call Trace: [ 989.719975] [ 989.723125] __schedule+0xcc3/0x19c0 [ 989.727942] ? io_schedule_timeout+0x140/0x140 [ 989.733728] ? find_held_lock+0x2b/0x80 [ 989.738834] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.744720] schedule+0xd8/0x260 [ 989.749140] schedule_preempt_disabled+0x18/0x30 [ 989.755121] __mutex_lock+0x6af/0x2010 [ 989.760127] ? threaded_store+0x132/0x220 [ 989.765429] ? ww_mutex_lock+0x160/0x160 [ 989.770627] ? selinux_inode_free_security+0x330/0x330 [ 989.777200] ? cap_capable+0x1d6/0x3e0 [ 989.782208] ? threaded_store+0x132/0x220 [ 989.787506] threaded_store+0x132/0x220 [ 989.792613] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.797909] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.803209] ? sysfs_kf_write+0x65/0x160 [ 989.808410] ? sysfs_file_ops+0x140/0x140 [ 989.813706] kernfs_fop_write_iter+0x335/0x510 [ 989.819492] ? kernfs_ops+0xf0/0xf0 [ 989.824203] new_sync_write+0x333/0x750 [ 989.829297] ? __lock_acquire+0x508/0xc10 [ 989.834596] ? new_sync_read+0x740/0x740 [ 989.839796] ? lock_acquire.part.0+0xbc/0x260 [ 989.845476] ? ksys_write+0x116/0x250 [ 989.850385] vfs_write+0x657/0x9b0 [ 989.855000] ksys_write+0x116/0x250 [ 989.859703] ? __ia32_sys_read+0xc0/0xc0 [ 989.864900] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.870490] ? rcu_is_watching+0x15/0xd0 [ 989.875694] do_syscall_64+0xf3/0x650 [ 989.880603] ? trace_hardirqs_off+0xd/0x30 [ 989.885999] ? exc_page_fault+0xda/0xf0 [ 989.891102] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.897578] RIP: 0033:0x7f042600464e [ 989.902389] RSP: 002b:00007fff57af98f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.911685] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f042600464e [ 989.920486] RDX: 0000000000000001 RSI: 000055f72d5cdbf0 RDI: 0000000000000007 [ 989.929293] RBP: 00007fff57af9900 R08: 0000000000000000 R09: 0000000000000000 [ 989.938103] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f0425e7d390 [ 989.946910] R13: 000055f72d5cdbf0 R14: 0000000000000007 R15: 00007f0425e11120 | [ 990.364028] #1: ff110001a6226e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.374991] #2: ff11000124aa6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.386148] #3: ff11000124af1db8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.396228] | [ 990.398694] =============================================\x0a [ 1112.558756] INFO: task python3:5409 blocked for more than 245 seconds. [ 1112.566909] Not tainted 7.1.0-rc6-ambq-g68fe9b8005df #1 [ 1112.574159] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.583747] task:python3 state:D stack:25672 pid:5409 tgid:5409 ppid:5408 task_flags:0x400100 flags:0x00080000 [ 1112.596951] Call Trace: [ 1112.600489] [ 1112.603637] __schedule+0xcc3/0x19c0 [ 1112.608452] ? io_schedule_timeout+0x140/0x140 [ 1112.614236] ? find_held_lock+0x2b/0x80 [ 1112.619333] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.625215] schedule+0xd8/0x260 [ 1112.629634] schedule_preempt_disabled+0x18/0x30 [ 1112.635613] __mutex_lock+0x6af/0x2010 [ 1112.640618] ? threaded_store+0x132/0x220 [ 1112.645915] ? ww_mutex_lock+0x160/0x160 [ 1112.651113] ? selinux_inode_free_security+0x330/0x330 [ 1112.657681] ? cap_capable+0x1d6/0x3e0 [ 1112.662689] ? threaded_store+0x132/0x220 [ 1112.667987] threaded_store+0x132/0x220 [ 1112.673088] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.678385] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.683681] ? sysfs_kf_write+0x65/0x160 [ 1112.688880] ? sysfs_file_ops+0x140/0x140 [ 1112.694175] kernfs_fop_write_iter+0x335/0x510 [ 1112.699958] ? kernfs_ops+0xf0/0xf0 [ 1112.704668] new_sync_write+0x333/0x750 [ 1112.709770] ? __lock_acquire+0x508/0xc10 [ 1112.715065] ? new_sync_read+0x740/0x740 [ 1112.720267] ? lock_acquire.part.0+0xbc/0x260 [ 1112.725952] ? ksys_write+0x116/0x250 [ 1112.730860] vfs_write+0x657/0x9b0 [ 1112.735475] ksys_write+0x116/0x250 [ 1112.740186] ? __ia32_sys_read+0xc0/0xc0 [ 1112.745382] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.750972] ? rcu_is_watching+0x15/0xd0 [ 1112.756171] do_syscall_64+0xf3/0x650 [ 1112.761073] ? trace_hardirqs_off+0xd/0x30 [ 1112.766467] ? exc_page_fault+0xda/0xf0 [ 1112.771569] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.778034] RIP: 0033:0x7f042600464e [ 1112.782843] RSP: 002b:00007fff57af98f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.792141] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f042600464e [ 1112.800950] RDX: 0000000000000001 RSI: 000055f72d5cdbf0 RDI: 0000000000000007 [ 1112.809758] RBP: 00007fff57af9900 R08: 0000000000000000 R09: 0000000000000000 [ 1112.818557] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f0425e7d390 [ 1112.827366] R13: 000055f72d5cdbf0 R14: 0000000000000007 R15: 00007f0425e11120 | [ 1113.243816] #1: ff110001a6226e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.254776] #2: ff11000124aa6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.265932] #3: ff11000124af1db8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.276018] | [ 1113.278480] =============================================\x0a [ 1235.439969] INFO: task python3:5409 blocked for more than 368 seconds. [ 1235.448113] Not tainted 7.1.0-rc6-ambq-g68fe9b8005df #1 [ 1235.455364] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.464953] task:python3 state:D stack:25672 pid:5409 tgid:5409 ppid:5408 task_flags:0x400100 flags:0x00080002 [ 1235.478157] Call Trace: [ 1235.481696] [ 1235.484847] __schedule+0xcc3/0x19c0 [ 1235.489663] ? io_schedule_timeout+0x140/0x140 [ 1235.495447] ? find_held_lock+0x2b/0x80 [ 1235.500544] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.506427] schedule+0xd8/0x260 [ 1235.510842] schedule_preempt_disabled+0x18/0x30 [ 1235.516820] __mutex_lock+0x6af/0x2010 [ 1235.521822] ? threaded_store+0x132/0x220 [ 1235.527123] ? ww_mutex_lock+0x160/0x160 [ 1235.532321] ? selinux_inode_free_security+0x330/0x330 [ 1235.538888] ? cap_capable+0x1d6/0x3e0 [ 1235.543896] ? threaded_store+0x132/0x220 [ 1235.549191] threaded_store+0x132/0x220 [ 1235.554293] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.559591] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.564891] ? sysfs_kf_write+0x65/0x160 [ 1235.570090] ? sysfs_file_ops+0x140/0x140 [ 1235.575386] kernfs_fop_write_iter+0x335/0x510 [ 1235.581171] ? kernfs_ops+0xf0/0xf0 [ 1235.585880] new_sync_write+0x333/0x750 [ 1235.590984] ? __lock_acquire+0x508/0xc10 [ 1235.596279] ? new_sync_read+0x740/0x740 [ 1235.601480] ? lock_acquire.part.0+0xbc/0x260 [ 1235.607163] ? ksys_write+0x116/0x250 [ 1235.612071] vfs_write+0x657/0x9b0 [ 1235.616686] ksys_write+0x116/0x250 [ 1235.621389] ? __ia32_sys_read+0xc0/0xc0 [ 1235.626584] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.632175] ? rcu_is_watching+0x15/0xd0 [ 1235.637375] do_syscall_64+0xf3/0x650 [ 1235.642278] ? trace_hardirqs_off+0xd/0x30 [ 1235.647673] ? exc_page_fault+0xda/0xf0 [ 1235.652774] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.659239] RIP: 0033:0x7f042600464e [ 1235.664047] RSP: 002b:00007fff57af98f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.673344] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f042600464e [ 1235.682144] RDX: 0000000000000001 RSI: 000055f72d5cdbf0 RDI: 0000000000000007 [ 1235.690943] RBP: 00007fff57af9900 R08: 0000000000000000 R09: 0000000000000000 [ 1235.699739] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f0425e7d390 [ 1235.708547] R13: 000055f72d5cdbf0 R14: 0000000000000007 R15: 00007f0425e11120 | [ 1236.143695] #2: ffffffffaed69c20 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 1236.154361] #3: ffffffffaeb687b0 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x650 | [ 1236.166004] #4: ffffffffaed69990 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x650 | [ 1236.178429] | [ 1236.180892] =============================================\x0a [ 1358.321184] INFO: task python3:5409 blocked for more than 491 seconds. [ 1358.329331] Not tainted 7.1.0-rc6-ambq-g68fe9b8005df #1 [ 1358.336580] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.346160] task:python3 state:D stack:25672 pid:5409 tgid:5409 ppid:5408 task_flags:0x400100 flags:0x00080002 [ 1358.359367] Call Trace: [ 1358.362907] [ 1358.366059] __schedule+0xcc3/0x19c0 [ 1358.370875] ? io_schedule_timeout+0x140/0x140 [ 1358.376660] ? find_held_lock+0x2b/0x80 [ 1358.381765] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.387654] schedule+0xd8/0x260 [ 1358.392082] schedule_preempt_disabled+0x18/0x30 [ 1358.398061] __mutex_lock+0x6af/0x2010 [ 1358.403063] ? threaded_store+0x132/0x220 [ 1358.408363] ? ww_mutex_lock+0x160/0x160 [ 1358.413560] ? selinux_inode_free_security+0x330/0x330 [ 1358.420119] ? cap_capable+0x1d6/0x3e0 [ 1358.425126] ? threaded_store+0x132/0x220 [ 1358.430421] threaded_store+0x132/0x220 [ 1358.435521] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.440818] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.446113] ? sysfs_kf_write+0x65/0x160 [ 1358.451312] ? sysfs_file_ops+0x140/0x140 [ 1358.456608] kernfs_fop_write_iter+0x335/0x510 [ 1358.462391] ? kernfs_ops+0xf0/0xf0 [ 1358.467101] new_sync_write+0x333/0x750 [ 1358.472204] ? __lock_acquire+0x508/0xc10 [ 1358.477500] ? new_sync_read+0x740/0x740 [ 1358.482701] ? lock_acquire.part.0+0xbc/0x260 [ 1358.488386] ? ksys_write+0x116/0x250 [ 1358.493294] vfs_write+0x657/0x9b0 [ 1358.497909] ksys_write+0x116/0x250 [ 1358.502617] ? __ia32_sys_read+0xc0/0xc0 [ 1358.507812] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.513401] ? rcu_is_watching+0x15/0xd0 [ 1358.518603] do_syscall_64+0xf3/0x650 [ 1358.523497] ? trace_hardirqs_off+0xd/0x30 [ 1358.528893] ? exc_page_fault+0xda/0xf0 [ 1358.533995] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.540459] RIP: 0033:0x7f042600464e [ 1358.545266] RSP: 002b:00007fff57af98f0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.554562] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f042600464e [ 1358.563367] RDX: 0000000000000001 RSI: 000055f72d5cdbf0 RDI: 0000000000000007 [ 1358.572175] RBP: 00007fff57af9900 R08: 0000000000000000 R09: 0000000000000000 [ 1358.580973] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f0425e7d390 [ 1358.589773] R13: 000055f72d5cdbf0 R14: 0000000000000007 R15: 00007f0425e11120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store