====================================== | [ 779.576957] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 779.579396] nipa-hw-worker: [4/40] Retrying drivers/net:napi_threaded.py | [ 779.732903] kselftest: Running tests in drivers/net [ 989.661645] INFO: task python3:5623 blocked for more than 122 seconds. [ 989.669873] Not tainted 7.0.0-rc6-yiqv-g629b28ff78c6 #1 [ 989.677125] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.686717] task:python3 state:D stack:25336 pid:5623 tgid:5623 ppid:5622 task_flags:0x400100 flags:0x00080000 [ 989.699924] Call Trace: [ 989.703469] [ 989.706621] __schedule+0xae3/0x14d0 [ 989.711436] ? io_schedule_timeout+0x140/0x140 [ 989.717224] ? find_held_lock+0x2b/0x80 [ 989.722328] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.728215] schedule+0xd4/0x260 [ 989.732633] schedule_preempt_disabled+0x18/0x30 [ 989.738612] __mutex_lock+0x6b2/0x1ee0 [ 989.743617] ? rcu_is_watching+0x15/0xd0 [ 989.748816] ? threaded_store+0x132/0x220 [ 989.754116] ? ww_mutex_lock+0x160/0x160 [ 989.759309] ? selinux_inode_free_security+0x330/0x330 [ 989.765882] ? cap_capable+0x1ed/0x3f0 [ 989.770892] ? threaded_store+0x132/0x220 [ 989.776187] threaded_store+0x132/0x220 [ 989.781292] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.786594] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.791893] ? sysfs_kf_write+0x65/0x160 [ 989.797095] ? sysfs_file_ops+0x140/0x140 [ 989.802389] kernfs_fop_write_iter+0x335/0x510 [ 989.808174] ? kernfs_ops+0xf0/0xf0 [ 989.812886] new_sync_write+0x333/0x750 [ 989.817992] ? __lock_acquire+0x508/0xc10 [ 989.823289] ? new_sync_read+0x740/0x740 [ 989.828488] ? lock_acquire.part.0+0xbc/0x260 [ 989.834175] ? ksys_write+0x116/0x250 [ 989.839078] vfs_write+0x657/0x9b0 [ 989.843691] ksys_write+0x116/0x250 [ 989.848402] ? __ia32_sys_read+0xc0/0xc0 [ 989.853601] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.859182] ? rcu_is_watching+0x15/0xd0 [ 989.864382] do_syscall_64+0xf3/0x5e0 [ 989.869289] ? trace_hardirqs_off+0xd/0x30 [ 989.874678] ? exc_page_fault+0xda/0xf0 [ 989.879785] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.886252] RIP: 0033:0x7f23aadf422e [ 989.891056] RSP: 002b:00007ffcf537f980 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.900356] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f23aadf422e [ 989.909164] RDX: 0000000000000001 RSI: 0000556f0d201f40 RDI: 0000000000000007 [ 989.917971] RBP: 00007ffcf537f990 R08: 0000000000000000 R09: 0000000000000000 [ 989.926779] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f23aac6c390 [ 989.935586] R13: 0000556f0d201f40 R14: 0000000000000007 R15: 0000000000000003 | [ 990.312475] #1: ff110001c601ca88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.323439] #2: ff1100012274b0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.334597] #3: ff110001227c9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.344685] | [ 990.347150] =============================================\x0a [ 1112.542771] INFO: task python3:5623 blocked for more than 245 seconds. [ 1112.550916] Not tainted 7.0.0-rc6-yiqv-g629b28ff78c6 #1 [ 1112.558169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.567764] task:python3 state:D stack:25336 pid:5623 tgid:5623 ppid:5622 task_flags:0x400100 flags:0x00080000 [ 1112.580979] Call Trace: [ 1112.584596] [ 1112.587750] __schedule+0xae3/0x14d0 [ 1112.592573] ? io_schedule_timeout+0x140/0x140 [ 1112.598500] ? find_held_lock+0x2b/0x80 [ 1112.603610] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.609500] schedule+0xd4/0x260 [ 1112.613922] schedule_preempt_disabled+0x18/0x30 [ 1112.619905] __mutex_lock+0x6b2/0x1ee0 [ 1112.624915] ? rcu_is_watching+0x15/0xd0 [ 1112.630119] ? threaded_store+0x132/0x220 [ 1112.635535] ? ww_mutex_lock+0x160/0x160 [ 1112.640738] ? selinux_inode_free_security+0x330/0x330 [ 1112.647319] ? cap_capable+0x1ed/0x3f0 [ 1112.652331] ? threaded_store+0x132/0x220 [ 1112.657634] threaded_store+0x132/0x220 [ 1112.662743] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.668157] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.673457] ? sysfs_kf_write+0x65/0x160 [ 1112.678653] ? sysfs_file_ops+0x140/0x140 [ 1112.683954] kernfs_fop_write_iter+0x335/0x510 [ 1112.689855] ? kernfs_ops+0xf0/0xf0 [ 1112.694572] new_sync_write+0x333/0x750 [ 1112.699678] ? __lock_acquire+0x508/0xc10 [ 1112.704979] ? new_sync_read+0x740/0x740 [ 1112.710184] ? lock_acquire.part.0+0xbc/0x260 [ 1112.715872] ? ksys_write+0x116/0x250 [ 1112.720791] vfs_write+0x657/0x9b0 [ 1112.725410] ksys_write+0x116/0x250 [ 1112.730126] ? __ia32_sys_read+0xc0/0xc0 [ 1112.735331] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.740926] ? rcu_is_watching+0x15/0xd0 [ 1112.746130] do_syscall_64+0xf3/0x5e0 [ 1112.751043] ? trace_hardirqs_off+0xd/0x30 [ 1112.756441] ? exc_page_fault+0xda/0xf0 [ 1112.761538] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.768010] RIP: 0033:0x7f23aadf422e [ 1112.772822] RSP: 002b:00007ffcf537f980 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.782126] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f23aadf422e [ 1112.790942] RDX: 0000000000000001 RSI: 0000556f0d201f40 RDI: 0000000000000007 [ 1112.799824] RBP: 00007ffcf537f990 R08: 0000000000000000 R09: 0000000000000000 [ 1112.808640] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f23aac6c390 [ 1112.817451] R13: 0000556f0d201f40 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.339747] | [ 1113.342213] =============================================\x0a | [ 1125.468482] block nvme0n1: No UUID available providing old NGUID | SUBSYSTEM=block | DEVICE=b259:0 [ 1235.423882] INFO: task python3:5623 blocked for more than 368 seconds. [ 1235.432027] Not tainted 7.0.0-rc6-yiqv-g629b28ff78c6 #1 [ 1235.439277] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.448864] task:python3 state:D stack:25336 pid:5623 tgid:5623 ppid:5622 task_flags:0x400100 flags:0x00080002 [ 1235.462069] Call Trace: [ 1235.465608] [ 1235.468759] __schedule+0xae3/0x14d0 [ 1235.473579] ? io_schedule_timeout+0x140/0x140 [ 1235.479362] ? find_held_lock+0x2b/0x80 [ 1235.484465] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.490348] schedule+0xd4/0x260 [ 1235.494763] schedule_preempt_disabled+0x18/0x30 [ 1235.500739] __mutex_lock+0x6b2/0x1ee0 [ 1235.505747] ? rcu_is_watching+0x15/0xd0 [ 1235.510948] ? threaded_store+0x132/0x220 [ 1235.516245] ? ww_mutex_lock+0x160/0x160 [ 1235.521442] ? selinux_inode_free_security+0x330/0x330 [ 1235.528010] ? cap_capable+0x1ed/0x3f0 [ 1235.533017] ? threaded_store+0x132/0x220 [ 1235.538313] threaded_store+0x132/0x220 [ 1235.543416] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.548715] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.554011] ? sysfs_kf_write+0x65/0x160 [ 1235.559209] ? sysfs_file_ops+0x140/0x140 [ 1235.564504] kernfs_fop_write_iter+0x335/0x510 [ 1235.570291] ? kernfs_ops+0xf0/0xf0 [ 1235.575001] new_sync_write+0x333/0x750 [ 1235.580105] ? __lock_acquire+0x508/0xc10 [ 1235.585398] ? new_sync_read+0x740/0x740 [ 1235.590599] ? lock_acquire.part.0+0xbc/0x260 [ 1235.596285] ? ksys_write+0x116/0x250 [ 1235.601192] vfs_write+0x657/0x9b0 [ 1235.605808] ksys_write+0x116/0x250 [ 1235.610520] ? __ia32_sys_read+0xc0/0xc0 [ 1235.615709] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.621295] ? rcu_is_watching+0x15/0xd0 [ 1235.626493] do_syscall_64+0xf3/0x5e0 [ 1235.631397] ? trace_hardirqs_off+0xd/0x30 [ 1235.636792] ? exc_page_fault+0xda/0xf0 [ 1235.641893] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.648362] RIP: 0033:0x7f23aadf422e [ 1235.653173] RSP: 002b:00007ffcf537f980 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.662470] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f23aadf422e [ 1235.671270] RDX: 0000000000000001 RSI: 0000556f0d201f40 RDI: 0000000000000007 [ 1235.680075] RBP: 00007ffcf537f990 R08: 0000000000000000 R09: 0000000000000000 [ 1235.688883] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f23aac6c390 [ 1235.697682] R13: 0000556f0d201f40 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.100597] #1: ff110001c601ca88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.111556] #2: ff1100012274b0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.122710] #3: ff110001227c9d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.132798] | [ 1236.135265] =============================================\x0a [ 1358.304031] INFO: task python3:5623 blocked for more than 491 seconds. [ 1358.312178] Not tainted 7.0.0-rc6-yiqv-g629b28ff78c6 #1 [ 1358.319428] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.329016] task:python3 state:D stack:25336 pid:5623 tgid:5623 ppid:5622 task_flags:0x400100 flags:0x00080002 [ 1358.342216] Call Trace: [ 1358.345754] [ 1358.348902] __schedule+0xae3/0x14d0 [ 1358.353718] ? io_schedule_timeout+0x140/0x140 [ 1358.359501] ? find_held_lock+0x2b/0x80 [ 1358.364606] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.370499] schedule+0xd4/0x260 [ 1358.374955] schedule_preempt_disabled+0x18/0x30 [ 1358.380935] __mutex_lock+0x6b2/0x1ee0 [ 1358.385939] ? rcu_is_watching+0x15/0xd0 [ 1358.391139] ? threaded_store+0x132/0x220 [ 1358.396446] ? ww_mutex_lock+0x160/0x160 [ 1358.401642] ? selinux_inode_free_security+0x330/0x330 [ 1358.408213] ? cap_capable+0x1ed/0x3f0 [ 1358.413219] ? threaded_store+0x132/0x220 [ 1358.418503] threaded_store+0x132/0x220 [ 1358.423606] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.428901] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.434201] ? sysfs_kf_write+0x65/0x160 [ 1358.439399] ? sysfs_file_ops+0x140/0x140 [ 1358.444692] kernfs_fop_write_iter+0x335/0x510 [ 1358.450478] ? kernfs_ops+0xf0/0xf0 [ 1358.455178] new_sync_write+0x333/0x750 [ 1358.460280] ? __lock_acquire+0x508/0xc10 [ 1358.465577] ? new_sync_read+0x740/0x740 [ 1358.470777] ? lock_acquire.part.0+0xbc/0x260 [ 1358.476452] ? ksys_write+0x116/0x250 [ 1358.481359] vfs_write+0x657/0x9b0 [ 1358.485974] ksys_write+0x116/0x250 [ 1358.490686] ? __ia32_sys_read+0xc0/0xc0 [ 1358.495878] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.501470] ? rcu_is_watching+0x15/0xd0 [ 1358.506667] do_syscall_64+0xf3/0x5e0 [ 1358.511574] ? trace_hardirqs_off+0xd/0x30 [ 1358.516968] ? exc_page_fault+0xda/0xf0 [ 1358.522068] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.528536] RIP: 0033:0x7f23aadf422e [ 1358.533345] RSP: 002b:00007ffcf537f980 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.542641] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f23aadf422e [ 1358.551449] RDX: 0000000000000001 RSI: 0000556f0d201f40 RDI: 0000000000000007 [ 1358.560248] RBP: 00007ffcf537f990 R08: 0000000000000000 R09: 0000000000000000 [ 1358.569048] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f23aac6c390 [ 1358.577855] R13: 0000556f0d201f40 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store