====================================== | [ 790.126046] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 790.128509] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 790.286612] kselftest: Running tests in drivers/net [ 989.684498] INFO: task python3:5880 blocked for more than 122 seconds. [ 989.692712] Not tainted 7.1.0-rc5-sswl-g3968d78bede8 #1 [ 989.700468] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.710056] task:python3 state:D stack:25672 pid:5880 tgid:5880 ppid:5879 task_flags:0x400100 flags:0x00080000 [ 989.723262] Call Trace: [ 989.726799] [ 989.729948] __schedule+0xcc3/0x19c0 [ 989.734767] ? io_schedule_timeout+0x140/0x140 [ 989.740553] ? find_held_lock+0x2b/0x80 [ 989.745658] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.751541] schedule+0xd8/0x260 [ 989.755960] schedule_preempt_disabled+0x18/0x30 [ 989.761940] __mutex_lock+0x6af/0x2010 [ 989.766937] ? threaded_store+0x132/0x220 [ 989.772238] ? ww_mutex_lock+0x160/0x160 [ 989.777435] ? selinux_inode_free_security+0x330/0x330 [ 989.784004] ? cap_capable+0x1d6/0x3e0 [ 989.789011] ? threaded_store+0x132/0x220 [ 989.794309] threaded_store+0x132/0x220 [ 989.799415] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.804711] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.810007] ? sysfs_kf_write+0x65/0x160 [ 989.815206] ? sysfs_file_ops+0x140/0x140 [ 989.820500] kernfs_fop_write_iter+0x335/0x510 [ 989.826283] ? kernfs_ops+0xf0/0xf0 [ 989.830993] new_sync_write+0x333/0x750 [ 989.836086] ? __lock_acquire+0x508/0xc10 [ 989.841380] ? new_sync_read+0x740/0x740 [ 989.846582] ? lock_acquire.part.0+0xbc/0x260 [ 989.852266] ? ksys_write+0x116/0x250 [ 989.857173] vfs_write+0x657/0x9b0 [ 989.861789] ksys_write+0x116/0x250 [ 989.866501] ? __ia32_sys_read+0xc0/0xc0 [ 989.871697] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.877283] ? rcu_is_watching+0x15/0xd0 [ 989.882485] do_syscall_64+0xf3/0x650 [ 989.887390] ? trace_hardirqs_off+0xd/0x30 [ 989.892786] ? exc_page_fault+0xda/0xf0 [ 989.897888] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.904353] RIP: 0033:0x7fb03694c22e [ 989.909163] RSP: 002b:00007ffd04741f50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.918460] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb03694c22e [ 989.927267] RDX: 0000000000000001 RSI: 000056033dd736b0 RDI: 0000000000000007 [ 989.936072] RBP: 00007ffd04741f60 R08: 0000000000000000 R09: 0000000000000000 [ 989.944877] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb0367c4390 [ 989.953684] R13: 000056033dd736b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.330618] #1: ff110001f252f480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.341580] #2: ff110001233a8b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.352740] #3: ff110001233f1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.362828] | [ 990.365294] =============================================\x0a [ 1112.566120] INFO: task python3:5880 blocked for more than 245 seconds. [ 1112.574268] Not tainted 7.1.0-rc5-sswl-g3968d78bede8 #1 [ 1112.581519] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.591109] task:python3 state:D stack:25672 pid:5880 tgid:5880 ppid:5879 task_flags:0x400100 flags:0x00080000 [ 1112.604317] Call Trace: [ 1112.607856] [ 1112.611010] __schedule+0xcc3/0x19c0 [ 1112.615829] ? io_schedule_timeout+0x140/0x140 [ 1112.621616] ? find_held_lock+0x2b/0x80 [ 1112.626722] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.632606] schedule+0xd8/0x260 [ 1112.637026] schedule_preempt_disabled+0x18/0x30 [ 1112.642998] __mutex_lock+0x6af/0x2010 [ 1112.648006] ? threaded_store+0x132/0x220 [ 1112.653305] ? ww_mutex_lock+0x160/0x160 [ 1112.658495] ? selinux_inode_free_security+0x330/0x330 [ 1112.665055] ? cap_capable+0x1d6/0x3e0 [ 1112.670065] ? threaded_store+0x132/0x220 [ 1112.675364] threaded_store+0x132/0x220 [ 1112.680465] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.685763] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.691064] ? sysfs_kf_write+0x65/0x160 [ 1112.696268] ? sysfs_file_ops+0x140/0x140 [ 1112.701564] kernfs_fop_write_iter+0x335/0x510 [ 1112.707352] ? kernfs_ops+0xf0/0xf0 [ 1112.712062] new_sync_write+0x333/0x750 [ 1112.717166] ? __lock_acquire+0x508/0xc10 [ 1112.722462] ? new_sync_read+0x740/0x740 [ 1112.727665] ? lock_acquire.part.0+0xbc/0x260 [ 1112.733353] ? ksys_write+0x116/0x250 [ 1112.738262] vfs_write+0x657/0x9b0 [ 1112.742878] ksys_write+0x116/0x250 [ 1112.747592] ? __ia32_sys_read+0xc0/0xc0 [ 1112.752792] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.758376] ? rcu_is_watching+0x15/0xd0 [ 1112.763576] do_syscall_64+0xf3/0x650 [ 1112.768476] ? trace_hardirqs_off+0xd/0x30 [ 1112.773872] ? exc_page_fault+0xda/0xf0 [ 1112.778976] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.785447] RIP: 0033:0x7fb03694c22e [ 1112.790257] RSP: 002b:00007ffd04741f50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.799547] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb03694c22e [ 1112.808357] RDX: 0000000000000001 RSI: 000056033dd736b0 RDI: 0000000000000007 [ 1112.817168] RBP: 00007ffd04741f60 R08: 0000000000000000 R09: 0000000000000000 [ 1112.825978] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb0367c4390 [ 1112.834785] R13: 000056033dd736b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.211675] #1: ff110001f252f480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.222639] #2: ff110001233a8b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.233798] #3: ff110001233f1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.243890] | [ 1113.246354] =============================================\x0a [ 1235.447756] INFO: task python3:5880 blocked for more than 368 seconds. [ 1235.455896] Not tainted 7.1.0-rc5-sswl-g3968d78bede8 #1 [ 1235.463136] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.472713] task:python3 state:D stack:25672 pid:5880 tgid:5880 ppid:5879 task_flags:0x400100 flags:0x00080002 [ 1235.485921] Call Trace: [ 1235.489457] [ 1235.492605] __schedule+0xcc3/0x19c0 [ 1235.497420] ? io_schedule_timeout+0x140/0x140 [ 1235.503206] ? find_held_lock+0x2b/0x80 [ 1235.508312] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.514196] schedule+0xd8/0x260 [ 1235.518614] schedule_preempt_disabled+0x18/0x30 [ 1235.524594] __mutex_lock+0x6af/0x2010 [ 1235.529590] ? threaded_store+0x132/0x220 [ 1235.534888] ? ww_mutex_lock+0x160/0x160 [ 1235.540085] ? selinux_inode_free_security+0x330/0x330 [ 1235.546654] ? cap_capable+0x1d6/0x3e0 [ 1235.551662] ? threaded_store+0x132/0x220 [ 1235.556961] threaded_store+0x132/0x220 [ 1235.562061] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.567356] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.572651] ? sysfs_kf_write+0x65/0x160 [ 1235.577848] ? sysfs_file_ops+0x140/0x140 [ 1235.583144] kernfs_fop_write_iter+0x335/0x510 [ 1235.588926] ? kernfs_ops+0xf0/0xf0 [ 1235.593634] new_sync_write+0x333/0x750 [ 1235.598738] ? __lock_acquire+0x508/0xc10 [ 1235.604024] ? new_sync_read+0x740/0x740 [ 1235.609225] ? lock_acquire.part.0+0xbc/0x260 [ 1235.614907] ? ksys_write+0x116/0x250 [ 1235.619817] vfs_write+0x657/0x9b0 [ 1235.624430] ksys_write+0x116/0x250 [ 1235.629139] ? __ia32_sys_read+0xc0/0xc0 [ 1235.634336] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.639922] ? rcu_is_watching+0x15/0xd0 [ 1235.645121] do_syscall_64+0xf3/0x650 [ 1235.650026] ? trace_hardirqs_off+0xd/0x30 [ 1235.655420] ? exc_page_fault+0xda/0xf0 [ 1235.660523] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.666989] RIP: 0033:0x7fb03694c22e [ 1235.671796] RSP: 002b:00007ffd04741f50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.681095] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb03694c22e [ 1235.689902] RDX: 0000000000000001 RSI: 000056033dd736b0 RDI: 0000000000000007 [ 1235.698708] RBP: 00007ffd04741f60 R08: 0000000000000000 R09: 0000000000000000 [ 1235.707513] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb0367c4390 [ 1235.716320] R13: 000056033dd736b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.093115] #1: ff110001f252f480 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.104064] #2: ff110001233a8b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.115222] #3: ff110001233f1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.125315] | [ 1236.127783] =============================================\x0a [ 1358.329349] INFO: task python3:5880 blocked for more than 491 seconds. [ 1358.337495] Not tainted 7.1.0-rc5-sswl-g3968d78bede8 #1 [ 1358.344744] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.354331] task:python3 state:D stack:25672 pid:5880 tgid:5880 ppid:5879 task_flags:0x400100 flags:0x00080002 [ 1358.367535] Call Trace: [ 1358.371074] [ 1358.374223] __schedule+0xcc3/0x19c0 [ 1358.379040] ? io_schedule_timeout+0x140/0x140 [ 1358.384825] ? find_held_lock+0x2b/0x80 [ 1358.389932] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.395815] schedule+0xd8/0x260 [ 1358.400222] schedule_preempt_disabled+0x18/0x30 [ 1358.406200] __mutex_lock+0x6af/0x2010 [ 1358.411204] ? threaded_store+0x132/0x220 [ 1358.416503] ? ww_mutex_lock+0x160/0x160 [ 1358.421701] ? selinux_inode_free_security+0x330/0x330 [ 1358.428270] ? cap_capable+0x1d6/0x3e0 [ 1358.433278] ? threaded_store+0x132/0x220 [ 1358.438575] threaded_store+0x132/0x220 [ 1358.443679] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.448974] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.454275] ? sysfs_kf_write+0x65/0x160 [ 1358.459475] ? sysfs_file_ops+0x140/0x140 [ 1358.464770] kernfs_fop_write_iter+0x335/0x510 [ 1358.470552] ? kernfs_ops+0xf0/0xf0 [ 1358.475261] new_sync_write+0x333/0x750 [ 1358.480365] ? __lock_acquire+0x508/0xc10 [ 1358.485659] ? new_sync_read+0x740/0x740 [ 1358.490861] ? lock_acquire.part.0+0xbc/0x260 [ 1358.496545] ? ksys_write+0x116/0x250 [ 1358.501454] vfs_write+0x657/0x9b0 [ 1358.506070] ksys_write+0x116/0x250 [ 1358.510771] ? __ia32_sys_read+0xc0/0xc0 [ 1358.515967] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.521557] ? rcu_is_watching+0x15/0xd0 [ 1358.526755] do_syscall_64+0xf3/0x650 [ 1358.531658] ? trace_hardirqs_off+0xd/0x30 [ 1358.537052] ? exc_page_fault+0xda/0xf0 [ 1358.542155] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.548619] RIP: 0033:0x7fb03694c22e [ 1358.553426] RSP: 002b:00007ffd04741f50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.562725] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb03694c22e [ 1358.571529] RDX: 0000000000000001 RSI: 000056033dd736b0 RDI: 0000000000000007 [ 1358.580334] RBP: 00007ffd04741f60 R08: 0000000000000000 R09: 0000000000000000 [ 1358.589141] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb0367c4390 [ 1358.597946] R13: 000056033dd736b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store