====================================== | [ 790.310965] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 790.313490] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 790.446430] kselftest: Running tests in drivers/net | [ 813.540631] kworker/u129:14 (311) used greatest stack depth: 21456 bytes left [ 989.670508] INFO: task python3:5850 blocked for more than 122 seconds. [ 989.678743] Not tainted 7.1.0-rc3-rnfr-g25a6e3c1d2bf #1 [ 989.686745] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.696340] task:python3 state:D stack:25672 pid:5850 tgid:5850 ppid:5849 task_flags:0x400100 flags:0x00080000 [ 989.709545] Call Trace: [ 989.713084] [ 989.716235] __schedule+0xcc3/0x19c0 [ 989.721053] ? io_schedule_timeout+0x140/0x140 [ 989.726837] ? find_held_lock+0x2b/0x80 [ 989.731943] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.737826] schedule+0xd4/0x260 [ 989.742234] schedule_preempt_disabled+0x18/0x30 [ 989.748211] __mutex_lock+0x6a3/0x2000 [ 989.753217] ? threaded_store+0x132/0x220 [ 989.758518] ? ww_mutex_lock+0x160/0x160 [ 989.763716] ? selinux_inode_free_security+0x330/0x330 [ 989.770285] ? cap_capable+0x1d6/0x3e0 [ 989.775292] ? threaded_store+0x132/0x220 [ 989.780588] threaded_store+0x132/0x220 [ 989.785690] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.790980] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.796281] ? sysfs_kf_write+0x65/0x160 [ 989.801479] ? sysfs_file_ops+0x140/0x140 [ 989.806774] kernfs_fop_write_iter+0x335/0x510 [ 989.812555] ? kernfs_ops+0xf0/0xf0 [ 989.817263] new_sync_write+0x333/0x750 [ 989.822365] ? __lock_acquire+0x508/0xc10 [ 989.827660] ? new_sync_read+0x740/0x740 [ 989.832861] ? lock_acquire.part.0+0xbc/0x260 [ 989.838547] ? ksys_write+0x116/0x250 [ 989.843456] vfs_write+0x657/0x9b0 [ 989.848072] ksys_write+0x116/0x250 [ 989.852784] ? __ia32_sys_read+0xc0/0xc0 [ 989.857973] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.863562] ? rcu_is_watching+0x15/0xd0 [ 989.868760] do_syscall_64+0xf3/0x650 [ 989.873667] ? trace_hardirqs_off+0xd/0x30 [ 989.879062] ? exc_page_fault+0xda/0xf0 [ 989.884165] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.890638] RIP: 0033:0x7f9b5089922e [ 989.895447] RSP: 002b:00007fff0a8f3840 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.904746] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9b5089922e [ 989.913551] RDX: 0000000000000001 RSI: 000055d28973fcd0 RDI: 0000000000000007 [ 989.922356] RBP: 00007fff0a8f3850 R08: 0000000000000000 R09: 0000000000000000 [ 989.931163] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9b50711390 [ 989.939961] R13: 000055d28973fcd0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.356370] #1: ff11000128de6880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.367330] #2: ff110001235b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.378484] #3: ff1100011c5b1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.388572] | [ 990.391035] =============================================\x0a [ 1112.550791] INFO: task python3:5850 blocked for more than 245 seconds. [ 1112.558937] Not tainted 7.1.0-rc3-rnfr-g25a6e3c1d2bf #1 [ 1112.566179] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.575772] task:python3 state:D stack:25672 pid:5850 tgid:5850 ppid:5849 task_flags:0x400100 flags:0x00080000 [ 1112.588977] Call Trace: [ 1112.592517] [ 1112.595666] __schedule+0xcc3/0x19c0 [ 1112.600485] ? io_schedule_timeout+0x140/0x140 [ 1112.606271] ? find_held_lock+0x2b/0x80 [ 1112.611376] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.617262] schedule+0xd4/0x260 [ 1112.621680] schedule_preempt_disabled+0x18/0x30 [ 1112.627659] __mutex_lock+0x6a3/0x2000 [ 1112.632663] ? threaded_store+0x132/0x220 [ 1112.637965] ? ww_mutex_lock+0x160/0x160 [ 1112.643165] ? selinux_inode_free_security+0x330/0x330 [ 1112.649736] ? cap_capable+0x1d6/0x3e0 [ 1112.654744] ? threaded_store+0x132/0x220 [ 1112.660041] threaded_store+0x132/0x220 [ 1112.665143] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.670444] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.675745] ? sysfs_kf_write+0x65/0x160 [ 1112.680948] ? sysfs_file_ops+0x140/0x140 [ 1112.686246] kernfs_fop_write_iter+0x335/0x510 [ 1112.692023] ? kernfs_ops+0xf0/0xf0 [ 1112.696735] new_sync_write+0x333/0x750 [ 1112.701839] ? __lock_acquire+0x508/0xc10 [ 1112.707127] ? new_sync_read+0x740/0x740 [ 1112.712329] ? lock_acquire.part.0+0xbc/0x260 [ 1112.718016] ? ksys_write+0x116/0x250 [ 1112.722918] vfs_write+0x657/0x9b0 [ 1112.727535] ksys_write+0x116/0x250 [ 1112.732249] ? __ia32_sys_read+0xc0/0xc0 [ 1112.737449] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.743041] ? rcu_is_watching+0x15/0xd0 [ 1112.748242] do_syscall_64+0xf3/0x650 [ 1112.753147] ? trace_hardirqs_off+0xd/0x30 [ 1112.758544] ? exc_page_fault+0xda/0xf0 [ 1112.763642] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.770109] RIP: 0033:0x7f9b5089922e [ 1112.774910] RSP: 002b:00007fff0a8f3840 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.784210] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9b5089922e [ 1112.793021] RDX: 0000000000000001 RSI: 000055d28973fcd0 RDI: 0000000000000007 [ 1112.801827] RBP: 00007fff0a8f3850 R08: 0000000000000000 R09: 0000000000000000 [ 1112.810641] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9b50711390 [ 1112.819451] R13: 000055d28973fcd0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.196370] #1: ff11000128de6880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.207332] #2: ff110001235b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.218492] #3: ff1100011c5b1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.228582] | [ 1113.231040] =============================================\x0a [ 1235.433105] INFO: task python3:5850 blocked for more than 368 seconds. [ 1235.441258] Not tainted 7.1.0-rc3-rnfr-g25a6e3c1d2bf #1 [ 1235.448510] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.458104] task:python3 state:D stack:25672 pid:5850 tgid:5850 ppid:5849 task_flags:0x400100 flags:0x00080002 [ 1235.471310] Call Trace: [ 1235.474850] [ 1235.478000] __schedule+0xcc3/0x19c0 [ 1235.482819] ? io_schedule_timeout+0x140/0x140 [ 1235.488607] ? find_held_lock+0x2b/0x80 [ 1235.493713] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.499601] schedule+0xd4/0x260 [ 1235.504022] schedule_preempt_disabled+0x18/0x30 [ 1235.510002] __mutex_lock+0x6a3/0x2000 [ 1235.514999] ? threaded_store+0x132/0x220 [ 1235.520302] ? ww_mutex_lock+0x160/0x160 [ 1235.525502] ? selinux_inode_free_security+0x330/0x330 [ 1235.532074] ? cap_capable+0x1d6/0x3e0 [ 1235.537082] ? threaded_store+0x132/0x220 [ 1235.542381] threaded_store+0x132/0x220 [ 1235.547487] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.552785] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.558085] ? sysfs_kf_write+0x65/0x160 [ 1235.563285] ? sysfs_file_ops+0x140/0x140 [ 1235.568582] kernfs_fop_write_iter+0x335/0x510 [ 1235.574367] ? kernfs_ops+0xf0/0xf0 [ 1235.579077] new_sync_write+0x333/0x750 [ 1235.584181] ? __lock_acquire+0x508/0xc10 [ 1235.589477] ? new_sync_read+0x740/0x740 [ 1235.594680] ? lock_acquire.part.0+0xbc/0x260 [ 1235.600365] ? ksys_write+0x116/0x250 [ 1235.605277] vfs_write+0x657/0x9b0 [ 1235.609893] ksys_write+0x116/0x250 [ 1235.614606] ? __ia32_sys_read+0xc0/0xc0 [ 1235.619807] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.625396] ? rcu_is_watching+0x15/0xd0 [ 1235.630601] do_syscall_64+0xf3/0x650 [ 1235.635509] ? trace_hardirqs_off+0xd/0x30 [ 1235.640904] ? exc_page_fault+0xda/0xf0 [ 1235.646006] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.652467] RIP: 0033:0x7f9b5089922e [ 1235.657276] RSP: 002b:00007fff0a8f3840 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.666577] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9b5089922e [ 1235.675383] RDX: 0000000000000001 RSI: 000055d28973fcd0 RDI: 0000000000000007 [ 1235.684190] RBP: 00007fff0a8f3850 R08: 0000000000000000 R09: 0000000000000000 [ 1235.692999] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9b50711390 [ 1235.701808] R13: 000055d28973fcd0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.107414] #1: ff11000128de6880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.118378] #2: ff110001235b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.129536] #3: ff1100011c5b1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.139629] | [ 1236.142097] =============================================\x0a [ 1358.314395] INFO: task python3:5850 blocked for more than 491 seconds. [ 1358.322544] Not tainted 7.1.0-rc3-rnfr-g25a6e3c1d2bf #1 [ 1358.329794] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.339385] task:python3 state:D stack:25672 pid:5850 tgid:5850 ppid:5849 task_flags:0x400100 flags:0x00080002 [ 1358.352591] Call Trace: [ 1358.356130] [ 1358.359284] __schedule+0xcc3/0x19c0 [ 1358.364102] ? io_schedule_timeout+0x140/0x140 [ 1358.369889] ? find_held_lock+0x2b/0x80 [ 1358.374997] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.380886] schedule+0xd4/0x260 [ 1358.385319] schedule_preempt_disabled+0x18/0x30 [ 1358.391303] __mutex_lock+0x6a3/0x2000 [ 1358.396310] ? threaded_store+0x132/0x220 [ 1358.401612] ? ww_mutex_lock+0x160/0x160 [ 1358.406810] ? selinux_inode_free_security+0x330/0x330 [ 1358.413383] ? cap_capable+0x1d6/0x3e0 [ 1358.418393] ? threaded_store+0x132/0x220 [ 1358.423689] threaded_store+0x132/0x220 [ 1358.428793] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.434089] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.439380] ? sysfs_kf_write+0x65/0x160 [ 1358.444580] ? sysfs_file_ops+0x140/0x140 [ 1358.449881] kernfs_fop_write_iter+0x335/0x510 [ 1358.455674] ? kernfs_ops+0xf0/0xf0 [ 1358.460387] new_sync_write+0x333/0x750 [ 1358.465491] ? __lock_acquire+0x508/0xc10 [ 1358.470787] ? new_sync_read+0x740/0x740 [ 1358.475988] ? lock_acquire.part.0+0xbc/0x260 [ 1358.481673] ? ksys_write+0x116/0x250 [ 1358.486583] vfs_write+0x657/0x9b0 [ 1358.491199] ksys_write+0x116/0x250 [ 1358.495911] ? __ia32_sys_read+0xc0/0xc0 [ 1358.501103] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.506691] ? rcu_is_watching+0x15/0xd0 [ 1358.511883] do_syscall_64+0xf3/0x650 [ 1358.516782] ? trace_hardirqs_off+0xd/0x30 [ 1358.522177] ? exc_page_fault+0xda/0xf0 [ 1358.527280] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.533750] RIP: 0033:0x7f9b5089922e [ 1358.538559] RSP: 002b:00007fff0a8f3840 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.547858] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9b5089922e [ 1358.556666] RDX: 0000000000000001 RSI: 000055d28973fcd0 RDI: 0000000000000007 [ 1358.565468] RBP: 00007fff0a8f3850 R08: 0000000000000000 R09: 0000000000000000 [ 1358.574277] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9b50711390 [ 1358.583085] R13: 000055d28973fcd0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store