====================================== | [ 790.092393] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 790.094867] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 790.227162] kselftest: Running tests in drivers/net | [ 838.140702] kworker/u129:14 (311) used greatest stack depth: 21456 bytes left [ 989.695518] INFO: task python3:5851 blocked for more than 122 seconds. [ 989.703742] Not tainted 7.1.0-rc5-qjtz-g9b5731360ceb #1 [ 989.711494] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.721084] task:python3 state:D stack:25672 pid:5851 tgid:5851 ppid:5850 task_flags:0x400100 flags:0x00080000 [ 989.734289] Call Trace: [ 989.737828] [ 989.740976] __schedule+0xcc3/0x19c0 [ 989.745794] ? io_schedule_timeout+0x140/0x140 [ 989.751580] ? find_held_lock+0x2b/0x80 [ 989.756682] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.762566] schedule+0xd8/0x260 [ 989.766982] schedule_preempt_disabled+0x18/0x30 [ 989.772961] __mutex_lock+0x6af/0x2010 [ 989.777967] ? threaded_store+0x132/0x220 [ 989.783268] ? ww_mutex_lock+0x160/0x160 [ 989.788465] ? selinux_inode_free_security+0x330/0x330 [ 989.795033] ? cap_capable+0x1d6/0x3e0 [ 989.800041] ? threaded_store+0x132/0x220 [ 989.805338] threaded_store+0x132/0x220 [ 989.810441] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.815738] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.821037] ? sysfs_kf_write+0x65/0x160 [ 989.826236] ? sysfs_file_ops+0x140/0x140 [ 989.831531] kernfs_fop_write_iter+0x335/0x510 [ 989.837317] ? kernfs_ops+0xf0/0xf0 [ 989.842027] new_sync_write+0x333/0x750 [ 989.847131] ? __lock_acquire+0x508/0xc10 [ 989.852425] ? new_sync_read+0x740/0x740 [ 989.857625] ? lock_acquire.part.0+0xbc/0x260 [ 989.863302] ? ksys_write+0x116/0x250 [ 989.868210] vfs_write+0x657/0x9b0 [ 989.872826] ksys_write+0x116/0x250 [ 989.877538] ? __ia32_sys_read+0xc0/0xc0 [ 989.882726] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.888315] ? rcu_is_watching+0x15/0xd0 [ 989.893516] do_syscall_64+0xf3/0x650 [ 989.898420] ? trace_hardirqs_off+0xd/0x30 [ 989.903815] ? exc_page_fault+0xda/0xf0 [ 989.908917] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.915387] RIP: 0033:0x7f012e60e22e [ 989.920197] RSP: 002b:00007ffca7aad300 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.929494] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f012e60e22e [ 989.938302] RDX: 0000000000000001 RSI: 000055dc59c286b0 RDI: 0000000000000007 [ 989.947101] RBP: 00007ffca7aad310 R08: 0000000000000000 R09: 0000000000000000 [ 989.955901] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f012e486390 [ 989.964709] R13: 000055dc59c286b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.369604] #1: ff11000107138280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.380562] #2: ff11000122d70b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.391717] #3: ff11000122e11d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.401811] | [ 990.404286] =============================================\x0a [ 1112.575947] INFO: task python3:5851 blocked for more than 245 seconds. [ 1112.584095] Not tainted 7.1.0-rc5-qjtz-g9b5731360ceb #1 [ 1112.591336] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.600928] task:python3 state:D stack:25672 pid:5851 tgid:5851 ppid:5850 task_flags:0x400100 flags:0x00080000 [ 1112.614135] Call Trace: [ 1112.617675] [ 1112.620827] __schedule+0xcc3/0x19c0 [ 1112.625645] ? io_schedule_timeout+0x140/0x140 [ 1112.631431] ? find_held_lock+0x2b/0x80 [ 1112.636536] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.642411] schedule+0xd8/0x260 [ 1112.646832] schedule_preempt_disabled+0x18/0x30 [ 1112.652813] __mutex_lock+0x6af/0x2010 [ 1112.657821] ? threaded_store+0x132/0x220 [ 1112.663118] ? ww_mutex_lock+0x160/0x160 [ 1112.668319] ? selinux_inode_free_security+0x330/0x330 [ 1112.674887] ? cap_capable+0x1d6/0x3e0 [ 1112.679896] ? threaded_store+0x132/0x220 [ 1112.685193] threaded_store+0x132/0x220 [ 1112.690294] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.695592] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.700896] ? sysfs_kf_write+0x65/0x160 [ 1112.706097] ? sysfs_file_ops+0x140/0x140 [ 1112.711394] kernfs_fop_write_iter+0x335/0x510 [ 1112.717181] ? kernfs_ops+0xf0/0xf0 [ 1112.721893] new_sync_write+0x333/0x750 [ 1112.726996] ? __lock_acquire+0x508/0xc10 [ 1112.732295] ? new_sync_read+0x740/0x740 [ 1112.737497] ? lock_acquire.part.0+0xbc/0x260 [ 1112.743182] ? ksys_write+0x116/0x250 [ 1112.748094] vfs_write+0x657/0x9b0 [ 1112.752711] ksys_write+0x116/0x250 [ 1112.757424] ? __ia32_sys_read+0xc0/0xc0 [ 1112.762625] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.768217] ? rcu_is_watching+0x15/0xd0 [ 1112.773421] do_syscall_64+0xf3/0x650 [ 1112.778330] ? trace_hardirqs_off+0xd/0x30 [ 1112.783725] ? exc_page_fault+0xda/0xf0 [ 1112.788827] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.795295] RIP: 0033:0x7f012e60e22e [ 1112.800105] RSP: 002b:00007ffca7aad300 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.809393] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f012e60e22e [ 1112.818193] RDX: 0000000000000001 RSI: 000055dc59c286b0 RDI: 0000000000000007 [ 1112.826991] RBP: 00007ffca7aad310 R08: 0000000000000000 R09: 0000000000000000 [ 1112.835801] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f012e486390 [ 1112.844610] R13: 000055dc59c286b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.221476] #1: ff11000107138280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.232440] #2: ff11000122d70b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.243602] #3: ff11000122e11d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.253693] | [ 1113.256161] =============================================\x0a [ 1235.458463] INFO: task python3:5851 blocked for more than 368 seconds. [ 1235.466602] Not tainted 7.1.0-rc5-qjtz-g9b5731360ceb #1 [ 1235.473843] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.483435] task:python3 state:D stack:25672 pid:5851 tgid:5851 ppid:5850 task_flags:0x400100 flags:0x00080002 [ 1235.496643] Call Trace: [ 1235.500183] [ 1235.503336] __schedule+0xcc3/0x19c0 [ 1235.508155] ? io_schedule_timeout+0x140/0x140 [ 1235.513941] ? find_held_lock+0x2b/0x80 [ 1235.519048] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.524933] schedule+0xd8/0x260 [ 1235.529352] schedule_preempt_disabled+0x18/0x30 [ 1235.535324] __mutex_lock+0x6af/0x2010 [ 1235.540331] ? threaded_store+0x132/0x220 [ 1235.545634] ? ww_mutex_lock+0x160/0x160 [ 1235.550834] ? selinux_inode_free_security+0x330/0x330 [ 1235.557403] ? cap_capable+0x1d6/0x3e0 [ 1235.562413] ? threaded_store+0x132/0x220 [ 1235.567712] threaded_store+0x132/0x220 [ 1235.572813] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.578111] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.583408] ? sysfs_kf_write+0x65/0x160 [ 1235.588608] ? sysfs_file_ops+0x140/0x140 [ 1235.593896] kernfs_fop_write_iter+0x335/0x510 [ 1235.599680] ? kernfs_ops+0xf0/0xf0 [ 1235.604391] new_sync_write+0x333/0x750 [ 1235.609496] ? __lock_acquire+0x508/0xc10 [ 1235.614792] ? new_sync_read+0x740/0x740 [ 1235.619993] ? lock_acquire.part.0+0xbc/0x260 [ 1235.625679] ? ksys_write+0x116/0x250 [ 1235.630589] vfs_write+0x657/0x9b0 [ 1235.635206] ksys_write+0x116/0x250 [ 1235.639919] ? __ia32_sys_read+0xc0/0xc0 [ 1235.645116] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.650706] ? rcu_is_watching+0x15/0xd0 [ 1235.655908] do_syscall_64+0xf3/0x650 [ 1235.660816] ? trace_hardirqs_off+0xd/0x30 [ 1235.666212] ? exc_page_fault+0xda/0xf0 [ 1235.671315] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.677786] RIP: 0033:0x7f012e60e22e [ 1235.682610] RSP: 002b:00007ffca7aad300 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.691915] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f012e60e22e [ 1235.700725] RDX: 0000000000000001 RSI: 000055dc59c286b0 RDI: 0000000000000007 [ 1235.709526] RBP: 00007ffca7aad310 R08: 0000000000000000 R09: 0000000000000000 [ 1235.718336] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f012e486390 [ 1235.727144] R13: 000055dc59c286b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.104087] #1: ff11000107138280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.115049] #2: ff11000122d70b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.126208] #3: ff11000122e11d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.136303] | [ 1236.138773] =============================================\x0a [ 1358.338962] INFO: task python3:5851 blocked for more than 491 seconds. [ 1358.347108] Not tainted 7.1.0-rc5-qjtz-g9b5731360ceb #1 [ 1358.354354] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.363945] task:python3 state:D stack:25672 pid:5851 tgid:5851 ppid:5850 task_flags:0x400100 flags:0x00080002 [ 1358.377160] Call Trace: [ 1358.380701] [ 1358.383858] __schedule+0xcc3/0x19c0 [ 1358.388678] ? io_schedule_timeout+0x140/0x140 [ 1358.394468] ? find_held_lock+0x2b/0x80 [ 1358.399567] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.405459] schedule+0xd8/0x260 [ 1358.409881] schedule_preempt_disabled+0x18/0x30 [ 1358.415865] __mutex_lock+0x6af/0x2010 [ 1358.420872] ? threaded_store+0x132/0x220 [ 1358.426179] ? ww_mutex_lock+0x160/0x160 [ 1358.431374] ? selinux_inode_free_security+0x330/0x330 [ 1358.437955] ? cap_capable+0x1d6/0x3e0 [ 1358.442966] ? threaded_store+0x132/0x220 [ 1358.448273] threaded_store+0x132/0x220 [ 1358.453379] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.458679] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.463983] ? sysfs_kf_write+0x65/0x160 [ 1358.469188] ? sysfs_file_ops+0x140/0x140 [ 1358.474490] kernfs_fop_write_iter+0x335/0x510 [ 1358.480278] ? kernfs_ops+0xf0/0xf0 [ 1358.484994] new_sync_write+0x333/0x750 [ 1358.490100] ? __lock_acquire+0x508/0xc10 [ 1358.495398] ? new_sync_read+0x740/0x740 [ 1358.500600] ? lock_acquire.part.0+0xbc/0x260 [ 1358.506290] ? ksys_write+0x116/0x250 [ 1358.511209] vfs_write+0x657/0x9b0 [ 1358.515826] ksys_write+0x116/0x250 [ 1358.520541] ? __ia32_sys_read+0xc0/0xc0 [ 1358.525741] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.531333] ? rcu_is_watching+0x15/0xd0 [ 1358.536537] do_syscall_64+0xf3/0x650 [ 1358.541447] ? trace_hardirqs_off+0xd/0x30 [ 1358.546846] ? exc_page_fault+0xda/0xf0 [ 1358.551956] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.558430] RIP: 0033:0x7f012e60e22e [ 1358.563244] RSP: 002b:00007ffca7aad300 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.572549] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f012e60e22e [ 1358.581365] RDX: 0000000000000001 RSI: 000055dc59c286b0 RDI: 0000000000000007 [ 1358.590175] RBP: 00007ffca7aad310 R08: 0000000000000000 R09: 0000000000000000 [ 1358.598992] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f012e486390 [ 1358.607808] R13: 000055dc59c286b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store