====================================== | [ 781.627151] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 781.630712] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 781.757957] kselftest: Running tests in drivers/net [ 989.678022] INFO: task python3:5772 blocked for more than 122 seconds. [ 989.686248] Not tainted 7.1.0-rc2-tboi-g442817b5d4df #1 [ 989.693498] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.703719] task:python3 state:D stack:25032 pid:5772 tgid:5772 ppid:5771 task_flags:0x400100 flags:0x00080000 [ 989.716917] Call Trace: [ 989.720455] [ 989.723607] __schedule+0xcba/0x1940 [ 989.728428] ? io_schedule_timeout+0x140/0x140 [ 989.734215] ? find_held_lock+0x2b/0x80 [ 989.739321] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.745206] schedule+0xd4/0x260 [ 989.749627] schedule_preempt_disabled+0x18/0x30 [ 989.755605] __mutex_lock+0x6a3/0x2000 [ 989.760612] ? threaded_store+0x132/0x220 [ 989.765911] ? ww_mutex_lock+0x160/0x160 [ 989.771109] ? selinux_inode_free_security+0x330/0x330 [ 989.777681] ? cap_capable+0x1d6/0x3e0 [ 989.782691] ? threaded_store+0x132/0x220 [ 989.787989] threaded_store+0x132/0x220 [ 989.793084] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.798379] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.803680] ? sysfs_kf_write+0x65/0x160 [ 989.808880] ? sysfs_file_ops+0x140/0x140 [ 989.814174] kernfs_fop_write_iter+0x335/0x510 [ 989.819960] ? kernfs_ops+0xf0/0xf0 [ 989.824672] new_sync_write+0x333/0x750 [ 989.829776] ? __lock_acquire+0x508/0xc10 [ 989.835073] ? new_sync_read+0x740/0x740 [ 989.840272] ? lock_acquire.part.0+0xbc/0x260 [ 989.845960] ? ksys_write+0x116/0x250 [ 989.850863] vfs_write+0x657/0x9b0 [ 989.855477] ksys_write+0x116/0x250 [ 989.860191] ? __ia32_sys_read+0xc0/0xc0 [ 989.865389] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.870983] ? rcu_is_watching+0x15/0xd0 [ 989.876183] do_syscall_64+0xf3/0x650 [ 989.881083] ? trace_hardirqs_off+0xd/0x30 [ 989.886477] ? exc_page_fault+0xda/0xf0 [ 989.891581] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.898058] RIP: 0033:0x7fcfa9e1d22e [ 989.902871] RSP: 002b:00007ffdce58b570 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.912167] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcfa9e1d22e [ 989.920969] RDX: 0000000000000001 RSI: 0000560f0b975fe0 RDI: 0000000000000007 [ 989.929779] RBP: 00007ffdce58b580 R08: 0000000000000000 R09: 0000000000000000 [ 989.938591] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcfa9c95390 [ 989.947400] R13: 0000560f0b975fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.324327] #1: ff1100019356ac80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.335288] #2: ff1100012328cb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.346444] #3: ff110001233a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.356535] | [ 990.359002] =============================================\x0a [ 1112.559271] INFO: task python3:5772 blocked for more than 245 seconds. [ 1112.567420] Not tainted 7.1.0-rc2-tboi-g442817b5d4df #1 [ 1112.574669] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.584260] task:python3 state:D stack:25032 pid:5772 tgid:5772 ppid:5771 task_flags:0x400100 flags:0x00080000 [ 1112.597465] Call Trace: [ 1112.601005] [ 1112.604153] __schedule+0xcba/0x1940 [ 1112.608969] ? io_schedule_timeout+0x140/0x140 [ 1112.614753] ? find_held_lock+0x2b/0x80 [ 1112.619859] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.625741] schedule+0xd4/0x260 [ 1112.630159] schedule_preempt_disabled+0x18/0x30 [ 1112.636137] __mutex_lock+0x6a3/0x2000 [ 1112.641141] ? threaded_store+0x132/0x220 [ 1112.646431] ? ww_mutex_lock+0x160/0x160 [ 1112.651620] ? selinux_inode_free_security+0x330/0x330 [ 1112.658187] ? cap_capable+0x1d6/0x3e0 [ 1112.663194] ? threaded_store+0x132/0x220 [ 1112.668489] threaded_store+0x132/0x220 [ 1112.673587] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.678884] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.684185] ? sysfs_kf_write+0x65/0x160 [ 1112.689382] ? sysfs_file_ops+0x140/0x140 [ 1112.694678] kernfs_fop_write_iter+0x335/0x510 [ 1112.700463] ? kernfs_ops+0xf0/0xf0 [ 1112.705173] new_sync_write+0x333/0x750 [ 1112.710274] ? __lock_acquire+0x508/0xc10 [ 1112.715568] ? new_sync_read+0x740/0x740 [ 1112.720768] ? lock_acquire.part.0+0xbc/0x260 [ 1112.726452] ? ksys_write+0x116/0x250 [ 1112.731361] vfs_write+0x657/0x9b0 [ 1112.735973] ksys_write+0x116/0x250 [ 1112.740683] ? __ia32_sys_read+0xc0/0xc0 [ 1112.745881] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.751470] ? rcu_is_watching+0x15/0xd0 [ 1112.756670] do_syscall_64+0xf3/0x650 [ 1112.761576] ? trace_hardirqs_off+0xd/0x30 [ 1112.766969] ? exc_page_fault+0xda/0xf0 [ 1112.772069] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.778534] RIP: 0033:0x7fcfa9e1d22e [ 1112.783343] RSP: 002b:00007ffdce58b570 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.792640] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcfa9e1d22e [ 1112.801449] RDX: 0000000000000001 RSI: 0000560f0b975fe0 RDI: 0000000000000007 [ 1112.810258] RBP: 00007ffdce58b580 R08: 0000000000000000 R09: 0000000000000000 [ 1112.819067] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcfa9c95390 [ 1112.827876] R13: 0000560f0b975fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.282038] #1: ff1100019356ac80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.292996] #2: ff1100012328cb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.304150] #3: ff110001233a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.314239] | [ 1113.316705] =============================================\x0a [ 1235.439526] INFO: task python3:5772 blocked for more than 368 seconds. [ 1235.447677] Not tainted 7.1.0-rc2-tboi-g442817b5d4df #1 [ 1235.454926] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.464519] task:python3 state:D stack:25032 pid:5772 tgid:5772 ppid:5771 task_flags:0x400100 flags:0x00080002 [ 1235.477728] Call Trace: [ 1235.481268] [ 1235.484419] __schedule+0xcba/0x1940 [ 1235.489238] ? io_schedule_timeout+0x140/0x140 [ 1235.495023] ? find_held_lock+0x2b/0x80 [ 1235.500128] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.506017] schedule+0xd4/0x260 [ 1235.510436] schedule_preempt_disabled+0x18/0x30 [ 1235.516416] __mutex_lock+0x6a3/0x2000 [ 1235.521414] ? threaded_store+0x132/0x220 [ 1235.526716] ? ww_mutex_lock+0x160/0x160 [ 1235.531915] ? selinux_inode_free_security+0x330/0x330 [ 1235.538475] ? cap_capable+0x1d6/0x3e0 [ 1235.543489] ? threaded_store+0x132/0x220 [ 1235.548787] threaded_store+0x132/0x220 [ 1235.553893] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.559188] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.564477] ? sysfs_kf_write+0x65/0x160 [ 1235.569678] ? sysfs_file_ops+0x140/0x140 [ 1235.574973] kernfs_fop_write_iter+0x335/0x510 [ 1235.580759] ? kernfs_ops+0xf0/0xf0 [ 1235.585473] new_sync_write+0x333/0x750 [ 1235.590579] ? __lock_acquire+0x508/0xc10 [ 1235.595874] ? new_sync_read+0x740/0x740 [ 1235.601076] ? lock_acquire.part.0+0xbc/0x260 [ 1235.606762] ? ksys_write+0x116/0x250 [ 1235.611673] vfs_write+0x657/0x9b0 [ 1235.616288] ksys_write+0x116/0x250 [ 1235.620999] ? __ia32_sys_read+0xc0/0xc0 [ 1235.626198] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.631787] ? rcu_is_watching+0x15/0xd0 [ 1235.636993] do_syscall_64+0xf3/0x650 [ 1235.641901] ? trace_hardirqs_off+0xd/0x30 [ 1235.647294] ? exc_page_fault+0xda/0xf0 [ 1235.652398] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.658866] RIP: 0033:0x7fcfa9e1d22e [ 1235.663678] RSP: 002b:00007ffdce58b570 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.672976] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcfa9e1d22e [ 1235.681784] RDX: 0000000000000001 RSI: 0000560f0b975fe0 RDI: 0000000000000007 [ 1235.690592] RBP: 00007ffdce58b580 R08: 0000000000000000 R09: 0000000000000000 [ 1235.699402] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcfa9c95390 [ 1235.708210] R13: 0000560f0b975fe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.125271] #1: ff1100019356ac80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.136233] #2: ff1100012328cb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.147391] #3: ff110001233a1d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.157481] | [ 1236.159947] =============================================\x0a [ 1358.320781] INFO: task python3:5772 blocked for more than 491 seconds. [ 1358.328929] Not tainted 7.1.0-rc2-tboi-g442817b5d4df #1 [ 1358.336170] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.345759] task:python3 state:D stack:25032 pid:5772 tgid:5772 ppid:5771 task_flags:0x400100 flags:0x00080002 [ 1358.358965] Call Trace: [ 1358.362506] [ 1358.365660] __schedule+0xcba/0x1940 [ 1358.370477] ? io_schedule_timeout+0x140/0x140 [ 1358.376262] ? find_held_lock+0x2b/0x80 [ 1358.381366] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.387255] schedule+0xd4/0x260 [ 1358.391671] schedule_preempt_disabled+0x18/0x30 [ 1358.397652] __mutex_lock+0x6a3/0x2000 [ 1358.402657] ? threaded_store+0x132/0x220 [ 1358.407959] ? ww_mutex_lock+0x160/0x160 [ 1358.413160] ? selinux_inode_free_security+0x330/0x330 [ 1358.419730] ? cap_capable+0x1d6/0x3e0 [ 1358.424747] ? threaded_store+0x132/0x220 [ 1358.430053] threaded_store+0x132/0x220 [ 1358.435156] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.440452] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.445742] ? sysfs_kf_write+0x65/0x160 [ 1358.450941] ? sysfs_file_ops+0x140/0x140 [ 1358.456236] kernfs_fop_write_iter+0x335/0x510 [ 1358.462023] ? kernfs_ops+0xf0/0xf0 [ 1358.466733] new_sync_write+0x333/0x750 [ 1358.471836] ? __lock_acquire+0x508/0xc10 [ 1358.477134] ? new_sync_read+0x740/0x740 [ 1358.482335] ? lock_acquire.part.0+0xbc/0x260 [ 1358.488021] ? ksys_write+0x116/0x250 [ 1358.492933] vfs_write+0x657/0x9b0 [ 1358.497551] ksys_write+0x116/0x250 [ 1358.502264] ? __ia32_sys_read+0xc0/0xc0 [ 1358.507464] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.513044] ? rcu_is_watching+0x15/0xd0 [ 1358.518238] do_syscall_64+0xf3/0x650 [ 1358.523145] ? trace_hardirqs_off+0xd/0x30 [ 1358.528540] ? exc_page_fault+0xda/0xf0 [ 1358.533645] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.540114] RIP: 0033:0x7fcfa9e1d22e [ 1358.544924] RSP: 002b:00007ffdce58b570 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.554222] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fcfa9e1d22e [ 1358.563030] RDX: 0000000000000001 RSI: 0000560f0b975fe0 RDI: 0000000000000007 [ 1358.571839] RBP: 00007ffdce58b580 R08: 0000000000000000 R09: 0000000000000000 [ 1358.580647] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fcfa9c95390 [ 1358.589455] R13: 0000560f0b975fe0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store