====================================== | [ 763.394942] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 763.397315] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 763.603743] kselftest: Running tests in drivers/net [ 989.708178] INFO: task python3:5496 blocked for more than 122 seconds. [ 989.716406] Not tainted 7.1.0-rc6-igqq-geedd24e6ca78 #1 [ 989.724278] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.733870] task:python3 state:D stack:25672 pid:5496 tgid:5496 ppid:5495 task_flags:0x400100 flags:0x00080000 [ 989.747076] Call Trace: [ 989.750615] [ 989.753767] __schedule+0xcc3/0x19c0 [ 989.758587] ? io_schedule_timeout+0x140/0x140 [ 989.764371] ? find_held_lock+0x2b/0x80 [ 989.769478] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.775363] schedule+0xd8/0x260 [ 989.779783] schedule_preempt_disabled+0x18/0x30 [ 989.785763] __mutex_lock+0x6af/0x2010 [ 989.790760] ? threaded_store+0x132/0x220 [ 989.796060] ? ww_mutex_lock+0x160/0x160 [ 989.801259] ? selinux_inode_free_security+0x330/0x330 [ 989.807823] ? cap_capable+0x1d6/0x3e0 [ 989.812831] ? threaded_store+0x132/0x220 [ 989.818129] threaded_store+0x132/0x220 [ 989.823235] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.828533] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.833832] ? sysfs_kf_write+0x65/0x160 [ 989.839027] ? sysfs_file_ops+0x140/0x140 [ 989.844324] kernfs_fop_write_iter+0x335/0x510 [ 989.850102] ? kernfs_ops+0xf0/0xf0 [ 989.854813] new_sync_write+0x333/0x750 [ 989.859915] ? __lock_acquire+0x508/0xc10 [ 989.865213] ? new_sync_read+0x740/0x740 [ 989.870416] ? lock_acquire.part.0+0xbc/0x260 [ 989.876101] ? ksys_write+0x116/0x250 [ 989.881018] vfs_write+0x657/0x9b0 [ 989.885635] ksys_write+0x116/0x250 [ 989.890348] ? __ia32_sys_read+0xc0/0xc0 [ 989.895538] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.901129] ? rcu_is_watching+0x15/0xd0 [ 989.906334] do_syscall_64+0xf3/0x650 [ 989.911244] ? trace_hardirqs_off+0xd/0x30 [ 989.916638] ? exc_page_fault+0xda/0xf0 [ 989.921740] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.928199] RIP: 0033:0x7faecd24a64e [ 989.933014] RSP: 002b:00007ffdc61ad3c0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.942312] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007faecd24a64e [ 989.951120] RDX: 0000000000000001 RSI: 000055c4f5773bf0 RDI: 0000000000000007 [ 989.959922] RBP: 00007ffdc61ad3d0 R08: 0000000000000000 R09: 0000000000000000 [ 989.968730] R10: 0000000000000000 R11: 0000000000000202 R12: 00007faecd0c3390 [ 989.977537] R13: 000055c4f5773bf0 R14: 0000000000000007 R15: 00007faecd059120 | [ 990.348828] #1: ff110001a41cee80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.359788] #2: ff110001241fab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.370947] #3: ff11000124279db8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.381040] | [ 990.383505] =============================================\x0a [ 1112.589467] INFO: task python3:5496 blocked for more than 245 seconds. [ 1112.597616] Not tainted 7.1.0-rc6-igqq-geedd24e6ca78 #1 [ 1112.604868] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.614458] task:python3 state:D stack:25672 pid:5496 tgid:5496 ppid:5495 task_flags:0x400100 flags:0x00080000 [ 1112.627663] Call Trace: [ 1112.631204] [ 1112.634353] __schedule+0xcc3/0x19c0 [ 1112.639169] ? io_schedule_timeout+0x140/0x140 [ 1112.644957] ? find_held_lock+0x2b/0x80 [ 1112.650063] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.655949] schedule+0xd8/0x260 [ 1112.660367] schedule_preempt_disabled+0x18/0x30 [ 1112.666345] __mutex_lock+0x6af/0x2010 [ 1112.671350] ? threaded_store+0x132/0x220 [ 1112.676640] ? ww_mutex_lock+0x160/0x160 [ 1112.681838] ? selinux_inode_free_security+0x330/0x330 [ 1112.688400] ? cap_capable+0x1d6/0x3e0 [ 1112.693414] ? threaded_store+0x132/0x220 [ 1112.698754] threaded_store+0x132/0x220 [ 1112.703858] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.709156] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.714454] ? sysfs_kf_write+0x65/0x160 [ 1112.719653] ? sysfs_file_ops+0x140/0x140 [ 1112.724951] kernfs_fop_write_iter+0x335/0x510 [ 1112.730734] ? kernfs_ops+0xf0/0xf0 [ 1112.735448] new_sync_write+0x333/0x750 [ 1112.740554] ? __lock_acquire+0x508/0xc10 [ 1112.745850] ? new_sync_read+0x740/0x740 [ 1112.751053] ? lock_acquire.part.0+0xbc/0x260 [ 1112.756739] ? ksys_write+0x116/0x250 [ 1112.761649] vfs_write+0x657/0x9b0 [ 1112.766266] ksys_write+0x116/0x250 [ 1112.770978] ? __ia32_sys_read+0xc0/0xc0 [ 1112.776176] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.781767] ? rcu_is_watching+0x15/0xd0 [ 1112.786969] do_syscall_64+0xf3/0x650 [ 1112.791873] ? trace_hardirqs_off+0xd/0x30 [ 1112.797270] ? exc_page_fault+0xda/0xf0 [ 1112.802373] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.808843] RIP: 0033:0x7faecd24a64e [ 1112.813652] RSP: 002b:00007ffdc61ad3c0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.822951] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007faecd24a64e [ 1112.831761] RDX: 0000000000000001 RSI: 000055c4f5773bf0 RDI: 0000000000000007 [ 1112.840571] RBP: 00007ffdc61ad3d0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.849380] R10: 0000000000000000 R11: 0000000000000202 R12: 00007faecd0c3390 [ 1112.858189] R13: 000055c4f5773bf0 R14: 0000000000000007 R15: 00007faecd059120 | [ 1113.269780] #1: ff110001a41cee80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.280735] #2: ff110001241fab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.291893] #3: ff11000124279db8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.301981] | [ 1113.304447] =============================================\x0a [ 1235.470768] INFO: task python3:5496 blocked for more than 368 seconds. [ 1235.478919] Not tainted 7.1.0-rc6-igqq-geedd24e6ca78 #1 [ 1235.486169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.495757] task:python3 state:D stack:25672 pid:5496 tgid:5496 ppid:5495 task_flags:0x400100 flags:0x00080002 [ 1235.508963] Call Trace: [ 1235.512504] [ 1235.515654] __schedule+0xcc3/0x19c0 [ 1235.520473] ? io_schedule_timeout+0x140/0x140 [ 1235.526261] ? find_held_lock+0x2b/0x80 [ 1235.531366] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.537251] schedule+0xd8/0x260 [ 1235.541669] schedule_preempt_disabled+0x18/0x30 [ 1235.547648] __mutex_lock+0x6af/0x2010 [ 1235.552653] ? threaded_store+0x132/0x220 [ 1235.557942] ? ww_mutex_lock+0x160/0x160 [ 1235.563142] ? selinux_inode_free_security+0x330/0x330 [ 1235.569712] ? cap_capable+0x1d6/0x3e0 [ 1235.574720] ? threaded_store+0x132/0x220 [ 1235.580021] threaded_store+0x132/0x220 [ 1235.585125] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.590423] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.595721] ? sysfs_kf_write+0x65/0x160 [ 1235.600923] ? sysfs_file_ops+0x140/0x140 [ 1235.606220] kernfs_fop_write_iter+0x335/0x510 [ 1235.612007] ? kernfs_ops+0xf0/0xf0 [ 1235.616721] new_sync_write+0x333/0x750 [ 1235.621826] ? __lock_acquire+0x508/0xc10 [ 1235.627123] ? new_sync_read+0x740/0x740 [ 1235.632317] ? lock_acquire.part.0+0xbc/0x260 [ 1235.638004] ? ksys_write+0x116/0x250 [ 1235.642904] vfs_write+0x657/0x9b0 [ 1235.647523] ksys_write+0x116/0x250 [ 1235.652235] ? __ia32_sys_read+0xc0/0xc0 [ 1235.657425] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.663031] ? rcu_is_watching+0x15/0xd0 [ 1235.668232] do_syscall_64+0xf3/0x650 [ 1235.673138] ? trace_hardirqs_off+0xd/0x30 [ 1235.678534] ? exc_page_fault+0xda/0xf0 [ 1235.683638] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.690108] RIP: 0033:0x7faecd24a64e [ 1235.694919] RSP: 002b:00007ffdc61ad3c0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.704220] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007faecd24a64e [ 1235.713031] RDX: 0000000000000001 RSI: 000055c4f5773bf0 RDI: 0000000000000007 [ 1235.721841] RBP: 00007ffdc61ad3d0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.730651] R10: 0000000000000000 R11: 0000000000000202 R12: 00007faecd0c3390 [ 1235.739461] R13: 000055c4f5773bf0 R14: 0000000000000007 R15: 00007faecd059120 | [ 1236.151013] #1: ff110001a41cee80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.161976] #2: ff110001241fab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.173132] #3: ff11000124279db8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.183221] | [ 1236.185687] =============================================\x0a [ 1358.352056] INFO: task python3:5496 blocked for more than 491 seconds. [ 1358.360207] Not tainted 7.1.0-rc6-igqq-geedd24e6ca78 #1 [ 1358.367458] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.377047] task:python3 state:D stack:25672 pid:5496 tgid:5496 ppid:5495 task_flags:0x400100 flags:0x00080002 [ 1358.390245] Call Trace: [ 1358.393787] [ 1358.396937] __schedule+0xcc3/0x19c0 [ 1358.401753] ? io_schedule_timeout+0x140/0x140 [ 1358.407541] ? find_held_lock+0x2b/0x80 [ 1358.412646] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.418524] schedule+0xd8/0x260 [ 1358.422943] schedule_preempt_disabled+0x18/0x30 [ 1358.428922] __mutex_lock+0x6af/0x2010 [ 1358.433927] ? threaded_store+0x132/0x220 [ 1358.439228] ? ww_mutex_lock+0x160/0x160 [ 1358.444428] ? selinux_inode_free_security+0x330/0x330 [ 1358.451000] ? cap_capable+0x1d6/0x3e0 [ 1358.456007] ? threaded_store+0x132/0x220 [ 1358.461301] threaded_store+0x132/0x220 [ 1358.466405] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.471705] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.477006] ? sysfs_kf_write+0x65/0x160 [ 1358.482206] ? sysfs_file_ops+0x140/0x140 [ 1358.487504] kernfs_fop_write_iter+0x335/0x510 [ 1358.493291] ? kernfs_ops+0xf0/0xf0 [ 1358.498003] new_sync_write+0x333/0x750 [ 1358.503109] ? __lock_acquire+0x508/0xc10 [ 1358.508407] ? new_sync_read+0x740/0x740 [ 1358.513611] ? lock_acquire.part.0+0xbc/0x260 [ 1358.519298] ? ksys_write+0x116/0x250 [ 1358.524207] vfs_write+0x657/0x9b0 [ 1358.528819] ksys_write+0x116/0x250 [ 1358.533531] ? __ia32_sys_read+0xc0/0xc0 [ 1358.538728] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.544314] ? rcu_is_watching+0x15/0xd0 [ 1358.549515] do_syscall_64+0xf3/0x650 [ 1358.554419] ? trace_hardirqs_off+0xd/0x30 [ 1358.559815] ? exc_page_fault+0xda/0xf0 [ 1358.564917] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.571383] RIP: 0033:0x7faecd24a64e [ 1358.576193] RSP: 002b:00007ffdc61ad3c0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.585492] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007faecd24a64e [ 1358.594298] RDX: 0000000000000001 RSI: 000055c4f5773bf0 RDI: 0000000000000007 [ 1358.603104] RBP: 00007ffdc61ad3d0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.611911] R10: 0000000000000000 R11: 0000000000000202 R12: 00007faecd0c3390 [ 1358.620804] R13: 000055c4f5773bf0 R14: 0000000000000007 R15: 00007faecd059120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store