====================================== | [ 767.792044] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 767.794856] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 767.946355] kselftest: Running tests in drivers/net | [ 961.027606] kworker/u130:2 (348) used greatest stack depth: 21936 bytes left [ 989.699930] INFO: task python3:5487 blocked for more than 122 seconds. [ 989.708167] Not tainted 7.1.0-rc7-vnda-gb51d13b87305 #1 [ 989.716126] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.725705] task:python3 state:D stack:25424 pid:5487 tgid:5487 ppid:5486 task_flags:0x400100 flags:0x00080000 [ 989.738911] Call Trace: [ 989.742451] [ 989.745603] __schedule+0xcc3/0x19c0 [ 989.750421] ? io_schedule_timeout+0x140/0x140 [ 989.756206] ? find_held_lock+0x2b/0x80 [ 989.761311] schedule+0xd8/0x260 [ 989.765730] schedule_preempt_disabled+0x18/0x30 [ 989.771708] __mutex_lock+0x6af/0x2010 [ 989.776713] ? threaded_store+0x132/0x220 [ 989.782013] ? ww_mutex_lock+0x160/0x160 [ 989.787210] ? selinux_inode_free_security+0x330/0x330 [ 989.793776] ? cap_capable+0x1d6/0x3e0 [ 989.798783] ? threaded_store+0x132/0x220 [ 989.804079] threaded_store+0x132/0x220 [ 989.809182] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.814476] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.819773] ? sysfs_kf_write+0x65/0x160 [ 989.824974] ? sysfs_file_ops+0x140/0x140 [ 989.830270] kernfs_fop_write_iter+0x335/0x510 [ 989.836055] ? kernfs_ops+0xf0/0xf0 [ 989.840769] new_sync_write+0x333/0x750 [ 989.845871] ? __lock_acquire+0x508/0xc10 [ 989.851165] ? new_sync_read+0x740/0x740 [ 989.856365] ? lock_acquire.part.0+0xbc/0x260 [ 989.862051] ? ksys_write+0x116/0x250 [ 989.866958] vfs_write+0x657/0x9b0 [ 989.871572] ksys_write+0x116/0x250 [ 989.876282] ? __ia32_sys_read+0xc0/0xc0 [ 989.881481] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.887070] ? rcu_is_watching+0x15/0xd0 [ 989.892261] do_syscall_64+0xf3/0x650 [ 989.897168] ? trace_hardirqs_off+0xd/0x30 [ 989.902563] ? exc_page_fault+0xda/0xf0 [ 989.907664] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.914129] RIP: 0033:0x7fed9cc2064e [ 989.918940] RSP: 002b:00007ffcdda64080 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.928239] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fed9cc2064e [ 989.937045] RDX: 0000000000000001 RSI: 000055b5b5858bf0 RDI: 0000000000000007 [ 989.945853] RBP: 00007ffcdda64090 R08: 0000000000000000 R09: 0000000000000000 [ 989.954662] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fed9ca99390 [ 989.963470] R13: 000055b5b5858bf0 R14: 0000000000000007 R15: 00007fed9ca2d120 | [ 990.334695] #1: ff1100018806a080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.345658] #2: ff11000111012b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.356814] #3: ff11000111069e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.366902] | [ 990.369370] =============================================\x0a [ 1112.581208] INFO: task python3:5487 blocked for more than 245 seconds. [ 1112.589349] Not tainted 7.1.0-rc7-vnda-gb51d13b87305 #1 [ 1112.596607] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.606200] task:python3 state:D stack:25424 pid:5487 tgid:5487 ppid:5486 task_flags:0x400100 flags:0x00080000 [ 1112.619416] Call Trace: [ 1112.622959] [ 1112.626115] __schedule+0xcc3/0x19c0 [ 1112.630933] ? io_schedule_timeout+0x140/0x140 [ 1112.636724] ? find_held_lock+0x2b/0x80 [ 1112.641828] schedule+0xd8/0x260 [ 1112.646251] schedule_preempt_disabled+0x18/0x30 [ 1112.652233] __mutex_lock+0x6af/0x2010 [ 1112.657234] ? threaded_store+0x132/0x220 [ 1112.662537] ? ww_mutex_lock+0x160/0x160 [ 1112.667742] ? selinux_inode_free_security+0x330/0x330 [ 1112.674376] ? cap_capable+0x1d6/0x3e0 [ 1112.679391] ? threaded_store+0x132/0x220 [ 1112.684689] threaded_store+0x132/0x220 [ 1112.689798] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.695100] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.700406] ? sysfs_kf_write+0x65/0x160 [ 1112.705611] ? sysfs_file_ops+0x140/0x140 [ 1112.710912] kernfs_fop_write_iter+0x335/0x510 [ 1112.716704] ? kernfs_ops+0xf0/0xf0 [ 1112.721419] new_sync_write+0x333/0x750 [ 1112.726594] ? __lock_acquire+0x508/0xc10 [ 1112.731887] ? new_sync_read+0x740/0x740 [ 1112.737090] ? lock_acquire.part.0+0xbc/0x260 [ 1112.742783] ? ksys_write+0x116/0x250 [ 1112.747695] vfs_write+0x657/0x9b0 [ 1112.752318] ksys_write+0x116/0x250 [ 1112.757092] ? __ia32_sys_read+0xc0/0xc0 [ 1112.762287] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.767878] ? rcu_is_watching+0x15/0xd0 [ 1112.773085] do_syscall_64+0xf3/0x650 [ 1112.777995] ? trace_hardirqs_off+0xd/0x30 [ 1112.783397] ? exc_page_fault+0xda/0xf0 [ 1112.788503] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.794978] RIP: 0033:0x7fed9cc2064e [ 1112.799794] RSP: 002b:00007ffcdda64080 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.809101] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fed9cc2064e [ 1112.817913] RDX: 0000000000000001 RSI: 000055b5b5858bf0 RDI: 0000000000000007 [ 1112.826728] RBP: 00007ffcdda64090 R08: 0000000000000000 R09: 0000000000000000 [ 1112.835531] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fed9ca99390 [ 1112.844345] R13: 000055b5b5858bf0 R14: 0000000000000007 R15: 00007fed9ca2d120 | [ 1113.227221] #2: ff11000111012b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.238388] #3: ff11000111069e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.248486] 1 lock held by systemd/6558: | [ 1113.253692] | [ 1113.256162] =============================================\x0a [ 1235.462470] INFO: task python3:5487 blocked for more than 368 seconds. [ 1235.470620] Not tainted 7.1.0-rc7-vnda-gb51d13b87305 #1 [ 1235.477860] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.487451] task:python3 state:D stack:25424 pid:5487 tgid:5487 ppid:5486 task_flags:0x400100 flags:0x00080002 [ 1235.500658] Call Trace: [ 1235.504195] [ 1235.507346] __schedule+0xcc3/0x19c0 [ 1235.512162] ? io_schedule_timeout+0x140/0x140 [ 1235.517947] ? find_held_lock+0x2b/0x80 [ 1235.523056] schedule+0xd8/0x260 [ 1235.527474] schedule_preempt_disabled+0x18/0x30 [ 1235.533451] __mutex_lock+0x6af/0x2010 [ 1235.538456] ? threaded_store+0x132/0x220 [ 1235.543754] ? ww_mutex_lock+0x160/0x160 [ 1235.548951] ? selinux_inode_free_security+0x330/0x330 [ 1235.555520] ? cap_capable+0x1d6/0x3e0 [ 1235.560528] ? threaded_store+0x132/0x220 [ 1235.565822] threaded_store+0x132/0x220 [ 1235.570925] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.576214] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.581515] ? sysfs_kf_write+0x65/0x160 [ 1235.586713] ? sysfs_file_ops+0x140/0x140 [ 1235.592008] kernfs_fop_write_iter+0x335/0x510 [ 1235.597793] ? kernfs_ops+0xf0/0xf0 [ 1235.602503] new_sync_write+0x333/0x750 [ 1235.607597] ? __lock_acquire+0x508/0xc10 [ 1235.612894] ? new_sync_read+0x740/0x740 [ 1235.618096] ? lock_acquire.part.0+0xbc/0x260 [ 1235.623781] ? ksys_write+0x116/0x250 [ 1235.628689] vfs_write+0x657/0x9b0 [ 1235.633304] ksys_write+0x116/0x250 [ 1235.638018] ? __ia32_sys_read+0xc0/0xc0 [ 1235.643216] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.648803] ? rcu_is_watching+0x15/0xd0 [ 1235.654003] do_syscall_64+0xf3/0x650 [ 1235.658909] ? trace_hardirqs_off+0xd/0x30 [ 1235.664301] ? exc_page_fault+0xda/0xf0 [ 1235.669402] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.675871] RIP: 0033:0x7fed9cc2064e [ 1235.680682] RSP: 002b:00007ffcdda64080 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.689978] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fed9cc2064e [ 1235.698785] RDX: 0000000000000001 RSI: 000055b5b5858bf0 RDI: 0000000000000007 [ 1235.707593] RBP: 00007ffcdda64090 R08: 0000000000000000 R09: 0000000000000000 [ 1235.716400] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fed9ca99390 [ 1235.725207] R13: 000055b5b5858bf0 R14: 0000000000000007 R15: 00007fed9ca2d120 | [ 1236.096402] #1: ff1100018806a080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.107363] #2: ff11000111012b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.118519] #3: ff11000111069e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.128613] | [ 1236.131077] =============================================\x0a [ 1358.342726] INFO: task python3:5487 blocked for more than 491 seconds. [ 1358.350893] Not tainted 7.1.0-rc7-vnda-gb51d13b87305 #1 [ 1358.358149] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.367739] task:python3 state:D stack:25424 pid:5487 tgid:5487 ppid:5486 task_flags:0x400100 flags:0x00080002 [ 1358.380946] Call Trace: [ 1358.384483] [ 1358.387631] __schedule+0xcc3/0x19c0 [ 1358.392446] ? io_schedule_timeout+0x140/0x140 [ 1358.398318] ? find_held_lock+0x2b/0x80 [ 1358.403426] schedule+0xd8/0x260 [ 1358.407844] schedule_preempt_disabled+0x18/0x30 [ 1358.413821] __mutex_lock+0x6af/0x2010 [ 1358.418825] ? threaded_store+0x132/0x220 [ 1358.424115] ? ww_mutex_lock+0x160/0x160 [ 1358.429305] ? selinux_inode_free_security+0x330/0x330 [ 1358.435864] ? cap_capable+0x1d6/0x3e0 [ 1358.440872] ? threaded_store+0x132/0x220 [ 1358.446168] threaded_store+0x132/0x220 [ 1358.451271] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.456568] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.461930] ? sysfs_kf_write+0x65/0x160 [ 1358.467131] ? sysfs_file_ops+0x140/0x140 [ 1358.472416] kernfs_fop_write_iter+0x335/0x510 [ 1358.478203] ? kernfs_ops+0xf0/0xf0 [ 1358.482915] new_sync_write+0x333/0x750 [ 1358.488018] ? __lock_acquire+0x508/0xc10 [ 1358.493316] ? new_sync_read+0x740/0x740 [ 1358.498515] ? lock_acquire.part.0+0xbc/0x260 [ 1358.504202] ? ksys_write+0x116/0x250 [ 1358.509113] vfs_write+0x657/0x9b0 [ 1358.513725] ksys_write+0x116/0x250 [ 1358.518434] ? __ia32_sys_read+0xc0/0xc0 [ 1358.523629] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.529219] ? rcu_is_watching+0x15/0xd0 [ 1358.534418] do_syscall_64+0xf3/0x650 [ 1358.539326] ? trace_hardirqs_off+0xd/0x30 [ 1358.544722] ? exc_page_fault+0xda/0xf0 [ 1358.549883] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.556350] RIP: 0033:0x7fed9cc2064e [ 1358.561157] RSP: 002b:00007ffcdda64080 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.570456] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fed9cc2064e [ 1358.579269] RDX: 0000000000000001 RSI: 000055b5b5858bf0 RDI: 0000000000000007 [ 1358.588076] RBP: 00007ffcdda64090 R08: 0000000000000000 R09: 0000000000000000 [ 1358.596884] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fed9ca99390 [ 1358.605690] R13: 000055b5b5858bf0 R14: 0000000000000007 R15: 00007fed9ca2d120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store