====================================== | [ 784.080409] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 784.082912] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 784.233524] kselftest: Running tests in drivers/net [ 989.675917] INFO: task python3:5701 blocked for more than 122 seconds. [ 989.684158] Not tainted 7.1.0-rc5-xcjq-g6d4c1091aa5c #1 [ 989.692079] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.701673] task:python3 state:D stack:25672 pid:5701 tgid:5701 ppid:5700 task_flags:0x400100 flags:0x00080000 [ 989.714881] Call Trace: [ 989.718422] [ 989.721577] __schedule+0xcc3/0x19c0 [ 989.726398] ? io_schedule_timeout+0x140/0x140 [ 989.732183] ? find_held_lock+0x2b/0x80 [ 989.737291] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.743179] schedule+0xd8/0x260 [ 989.747596] schedule_preempt_disabled+0x18/0x30 [ 989.753576] __mutex_lock+0x6af/0x2010 [ 989.758575] ? threaded_store+0x132/0x220 [ 989.763876] ? ww_mutex_lock+0x160/0x160 [ 989.769077] ? selinux_inode_free_security+0x330/0x330 [ 989.775646] ? cap_capable+0x1d6/0x3e0 [ 989.780655] ? threaded_store+0x132/0x220 [ 989.785954] threaded_store+0x132/0x220 [ 989.791057] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.796357] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.801654] ? sysfs_kf_write+0x65/0x160 [ 989.806856] ? sysfs_file_ops+0x140/0x140 [ 989.812153] kernfs_fop_write_iter+0x335/0x510 [ 989.817938] ? kernfs_ops+0xf0/0xf0 [ 989.822639] new_sync_write+0x333/0x750 [ 989.827750] ? __lock_acquire+0x508/0xc10 [ 989.833047] ? new_sync_read+0x740/0x740 [ 989.838250] ? lock_acquire.part.0+0xbc/0x260 [ 989.843938] ? ksys_write+0x116/0x250 [ 989.848846] vfs_write+0x657/0x9b0 [ 989.853465] ksys_write+0x116/0x250 [ 989.858178] ? __ia32_sys_read+0xc0/0xc0 [ 989.863380] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.868970] ? rcu_is_watching+0x15/0xd0 [ 989.874172] do_syscall_64+0xf3/0x650 [ 989.879081] ? trace_hardirqs_off+0xd/0x30 [ 989.884477] ? exc_page_fault+0xda/0xf0 [ 989.889581] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.896048] RIP: 0033:0x7fbc3b55022e [ 989.900851] RSP: 002b:00007ffeaa800bd0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.910149] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fbc3b55022e [ 989.918960] RDX: 0000000000000001 RSI: 000055b0d725c6b0 RDI: 0000000000000007 [ 989.927769] RBP: 00007ffeaa800be0 R08: 0000000000000000 R09: 0000000000000000 [ 989.936578] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fbc3b3c8390 [ 989.945398] R13: 000055b0d725c6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.327720] #2: ff11000124dfeb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.338881] #3: ff11000124de1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.348972] | [ 990.351438] =============================================\x0a | [ 1092.076912] kworker/u129:14 (309) used greatest stack depth: 21456 bytes left [ 1112.557097] INFO: task python3:5701 blocked for more than 245 seconds. [ 1112.565246] Not tainted 7.1.0-rc5-xcjq-g6d4c1091aa5c #1 [ 1112.572496] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.582084] task:python3 state:D stack:25672 pid:5701 tgid:5701 ppid:5700 task_flags:0x400100 flags:0x00080000 [ 1112.595287] Call Trace: [ 1112.598826] [ 1112.601974] __schedule+0xcc3/0x19c0 [ 1112.606791] ? io_schedule_timeout+0x140/0x140 [ 1112.612575] ? find_held_lock+0x2b/0x80 [ 1112.617670] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.623554] schedule+0xd8/0x260 [ 1112.627970] schedule_preempt_disabled+0x18/0x30 [ 1112.633948] __mutex_lock+0x6af/0x2010 [ 1112.638950] ? threaded_store+0x132/0x220 [ 1112.644247] ? ww_mutex_lock+0x160/0x160 [ 1112.649445] ? selinux_inode_free_security+0x330/0x330 [ 1112.656014] ? cap_capable+0x1d6/0x3e0 [ 1112.661023] ? threaded_store+0x132/0x220 [ 1112.666318] threaded_store+0x132/0x220 [ 1112.671419] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.676719] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.682019] ? sysfs_kf_write+0x65/0x160 [ 1112.687210] ? sysfs_file_ops+0x140/0x140 [ 1112.692506] kernfs_fop_write_iter+0x335/0x510 [ 1112.698288] ? kernfs_ops+0xf0/0xf0 [ 1112.702998] new_sync_write+0x333/0x750 [ 1112.708102] ? __lock_acquire+0x508/0xc10 [ 1112.713397] ? new_sync_read+0x740/0x740 [ 1112.718597] ? lock_acquire.part.0+0xbc/0x260 [ 1112.724283] ? ksys_write+0x116/0x250 [ 1112.729192] vfs_write+0x657/0x9b0 [ 1112.733805] ksys_write+0x116/0x250 [ 1112.738517] ? __ia32_sys_read+0xc0/0xc0 [ 1112.743713] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.749298] ? rcu_is_watching+0x15/0xd0 [ 1112.754498] do_syscall_64+0xf3/0x650 [ 1112.759402] ? trace_hardirqs_off+0xd/0x30 [ 1112.764797] ? exc_page_fault+0xda/0xf0 [ 1112.769899] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.776364] RIP: 0033:0x7fbc3b55022e [ 1112.781171] RSP: 002b:00007ffeaa800bd0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.790470] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fbc3b55022e [ 1112.799278] RDX: 0000000000000001 RSI: 000055b0d725c6b0 RDI: 0000000000000007 [ 1112.808079] RBP: 00007ffeaa800be0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.816884] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fbc3b3c8390 [ 1112.825692] R13: 000055b0d725c6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.225075] #1: ff110001ea936280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.236034] #2: ff11000124dfeb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.247188] #3: ff11000124de1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.257277] | [ 1113.259742] =============================================\x0a [ 1235.437297] INFO: task python3:5701 blocked for more than 368 seconds. [ 1235.445445] Not tainted 7.1.0-rc5-xcjq-g6d4c1091aa5c #1 [ 1235.452697] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.462286] task:python3 state:D stack:25672 pid:5701 tgid:5701 ppid:5700 task_flags:0x400100 flags:0x00080002 [ 1235.475481] Call Trace: [ 1235.479020] [ 1235.482172] __schedule+0xcc3/0x19c0 [ 1235.486984] ? io_schedule_timeout+0x140/0x140 [ 1235.492769] ? find_held_lock+0x2b/0x80 [ 1235.497875] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.503758] schedule+0xd8/0x260 [ 1235.508173] schedule_preempt_disabled+0x18/0x30 [ 1235.514148] __mutex_lock+0x6af/0x2010 [ 1235.519153] ? threaded_store+0x132/0x220 [ 1235.524451] ? ww_mutex_lock+0x160/0x160 [ 1235.529648] ? selinux_inode_free_security+0x330/0x330 [ 1235.536217] ? cap_capable+0x1d6/0x3e0 [ 1235.541224] ? threaded_store+0x132/0x220 [ 1235.546522] threaded_store+0x132/0x220 [ 1235.551622] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.556919] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.562205] ? sysfs_kf_write+0x65/0x160 [ 1235.567406] ? sysfs_file_ops+0x140/0x140 [ 1235.572698] kernfs_fop_write_iter+0x335/0x510 [ 1235.578480] ? kernfs_ops+0xf0/0xf0 [ 1235.583191] new_sync_write+0x333/0x750 [ 1235.588292] ? __lock_acquire+0x508/0xc10 [ 1235.593588] ? new_sync_read+0x740/0x740 [ 1235.598789] ? lock_acquire.part.0+0xbc/0x260 [ 1235.604474] ? ksys_write+0x116/0x250 [ 1235.609383] vfs_write+0x657/0x9b0 [ 1235.613995] ksys_write+0x116/0x250 [ 1235.618707] ? __ia32_sys_read+0xc0/0xc0 [ 1235.623903] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.629492] ? rcu_is_watching+0x15/0xd0 [ 1235.634693] do_syscall_64+0xf3/0x650 [ 1235.639597] ? trace_hardirqs_off+0xd/0x30 [ 1235.644991] ? exc_page_fault+0xda/0xf0 [ 1235.650094] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.656559] RIP: 0033:0x7fbc3b55022e [ 1235.661365] RSP: 002b:00007ffeaa800bd0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.670663] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fbc3b55022e [ 1235.679471] RDX: 0000000000000001 RSI: 000055b0d725c6b0 RDI: 0000000000000007 [ 1235.688271] RBP: 00007ffeaa800be0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.697078] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fbc3b3c8390 [ 1235.705880] R13: 000055b0d725c6b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.105748] #1: ff110001ea936280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.116710] #2: ff11000124dfeb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.127865] #3: ff11000124de1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.137955] | [ 1236.140418] =============================================\x0a [ 1358.319464] INFO: task python3:5701 blocked for more than 491 seconds. [ 1358.327611] Not tainted 7.1.0-rc5-xcjq-g6d4c1091aa5c #1 [ 1358.334851] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.344440] task:python3 state:D stack:25672 pid:5701 tgid:5701 ppid:5700 task_flags:0x400100 flags:0x00080002 [ 1358.357645] Call Trace: [ 1358.361183] [ 1358.364335] __schedule+0xcc3/0x19c0 [ 1358.369148] ? io_schedule_timeout+0x140/0x140 [ 1358.374933] ? find_held_lock+0x2b/0x80 [ 1358.380038] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.385912] schedule+0xd8/0x260 [ 1358.390319] schedule_preempt_disabled+0x18/0x30 [ 1358.396299] __mutex_lock+0x6af/0x2010 [ 1358.401302] ? threaded_store+0x132/0x220 [ 1358.406606] ? ww_mutex_lock+0x160/0x160 [ 1358.411805] ? selinux_inode_free_security+0x330/0x330 [ 1358.418374] ? cap_capable+0x1d6/0x3e0 [ 1358.423382] ? threaded_store+0x132/0x220 [ 1358.428675] threaded_store+0x132/0x220 [ 1358.433776] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.439074] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.444375] ? sysfs_kf_write+0x65/0x160 [ 1358.449576] ? sysfs_file_ops+0x140/0x140 [ 1358.454868] kernfs_fop_write_iter+0x335/0x510 [ 1358.460649] ? kernfs_ops+0xf0/0xf0 [ 1358.465362] new_sync_write+0x333/0x750 [ 1358.470465] ? __lock_acquire+0x508/0xc10 [ 1358.475759] ? new_sync_read+0x740/0x740 [ 1358.480960] ? lock_acquire.part.0+0xbc/0x260 [ 1358.486647] ? ksys_write+0x116/0x250 [ 1358.491547] vfs_write+0x657/0x9b0 [ 1358.496161] ksys_write+0x116/0x250 [ 1358.500873] ? __ia32_sys_read+0xc0/0xc0 [ 1358.506061] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.511649] ? rcu_is_watching+0x15/0xd0 [ 1358.516849] do_syscall_64+0xf3/0x650 [ 1358.521753] ? trace_hardirqs_off+0xd/0x30 [ 1358.527148] ? exc_page_fault+0xda/0xf0 [ 1358.532250] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.538715] RIP: 0033:0x7fbc3b55022e [ 1358.543522] RSP: 002b:00007ffeaa800bd0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.552820] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fbc3b55022e [ 1358.561630] RDX: 0000000000000001 RSI: 000055b0d725c6b0 RDI: 0000000000000007 [ 1358.570437] RBP: 00007ffeaa800be0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.579247] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fbc3b3c8390 [ 1358.588055] R13: 000055b0d725c6b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store