====================================== | [ 785.847278] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 785.849703] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 785.977641] kselftest: Running tests in drivers/net | [ 829.931128] kworker/u130:0 (178) used greatest stack depth: 21456 bytes left [ 989.677783] INFO: task python3:5776 blocked for more than 122 seconds. [ 989.685977] Not tainted 7.1.0-rc6-fxsj-gd1384a325c14 #1 [ 989.693455] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.703042] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080000 [ 989.716247] Call Trace: [ 989.719784] [ 989.722934] __schedule+0xcc3/0x19c0 [ 989.727750] ? io_schedule_timeout+0x140/0x140 [ 989.733533] ? find_held_lock+0x2b/0x80 [ 989.738634] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.744521] schedule+0xd8/0x260 [ 989.748938] schedule_preempt_disabled+0x18/0x30 [ 989.754915] __mutex_lock+0x6af/0x2010 [ 989.759920] ? threaded_store+0x132/0x220 [ 989.765219] ? ww_mutex_lock+0x160/0x160 [ 989.770414] ? selinux_inode_free_security+0x330/0x330 [ 989.776985] ? cap_capable+0x1d6/0x3e0 [ 989.781991] ? threaded_store+0x132/0x220 [ 989.787278] threaded_store+0x132/0x220 [ 989.792381] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.797667] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.802962] ? sysfs_kf_write+0x65/0x160 [ 989.808160] ? sysfs_file_ops+0x140/0x140 [ 989.813454] kernfs_fop_write_iter+0x335/0x510 [ 989.819239] ? kernfs_ops+0xf0/0xf0 [ 989.823947] new_sync_write+0x333/0x750 [ 989.829049] ? __lock_acquire+0x508/0xc10 [ 989.834346] ? new_sync_read+0x740/0x740 [ 989.839537] ? lock_acquire.part.0+0xbc/0x260 [ 989.845221] ? ksys_write+0x116/0x250 [ 989.850132] vfs_write+0x657/0x9b0 [ 989.854747] ksys_write+0x116/0x250 [ 989.859448] ? __ia32_sys_read+0xc0/0xc0 [ 989.864647] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.870237] ? rcu_is_watching+0x15/0xd0 [ 989.875440] do_syscall_64+0xf3/0x650 [ 989.880346] ? trace_hardirqs_off+0xd/0x30 [ 989.885732] ? exc_page_fault+0xda/0xf0 [ 989.890832] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.897300] RIP: 0033:0x7f03f09ae22e [ 989.902109] RSP: 002b:00007fff43769ea0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.911405] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f03f09ae22e [ 989.920212] RDX: 0000000000000001 RSI: 0000556d9e586e90 RDI: 0000000000000007 [ 989.929020] RBP: 00007fff43769eb0 R08: 0000000000000000 R09: 0000000000000000 [ 989.937829] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f03f0826390 [ 989.946635] R13: 0000556d9e586e90 R14: 0000000000000007 R15: 0000000000000003 | [ 990.323445] #1: ff110001e7bc3880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.334395] #2: ff11000111ad4b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.345551] #3: ff11000111a81d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.355641] | [ 990.358096] =============================================\x0a [ 1112.559069] INFO: task python3:5776 blocked for more than 245 seconds. [ 1112.567216] Not tainted 7.1.0-rc6-fxsj-gd1384a325c14 #1 [ 1112.574466] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.584057] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080000 [ 1112.597265] Call Trace: [ 1112.600804] [ 1112.603957] __schedule+0xcc3/0x19c0 [ 1112.608776] ? io_schedule_timeout+0x140/0x140 [ 1112.614563] ? find_held_lock+0x2b/0x80 [ 1112.619669] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.625557] schedule+0xd8/0x260 [ 1112.629978] schedule_preempt_disabled+0x18/0x30 [ 1112.635960] __mutex_lock+0x6af/0x2010 [ 1112.640967] ? threaded_store+0x132/0x220 [ 1112.646269] ? ww_mutex_lock+0x160/0x160 [ 1112.651467] ? selinux_inode_free_security+0x330/0x330 [ 1112.658036] ? cap_capable+0x1d6/0x3e0 [ 1112.663044] ? threaded_store+0x132/0x220 [ 1112.668341] threaded_store+0x132/0x220 [ 1112.673445] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.678745] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.684047] ? sysfs_kf_write+0x65/0x160 [ 1112.689248] ? sysfs_file_ops+0x140/0x140 [ 1112.694545] kernfs_fop_write_iter+0x335/0x510 [ 1112.700331] ? kernfs_ops+0xf0/0xf0 [ 1112.705042] new_sync_write+0x333/0x750 [ 1112.710146] ? __lock_acquire+0x508/0xc10 [ 1112.715437] ? new_sync_read+0x740/0x740 [ 1112.720639] ? lock_acquire.part.0+0xbc/0x260 [ 1112.726324] ? ksys_write+0x116/0x250 [ 1112.731236] vfs_write+0x657/0x9b0 [ 1112.735852] ksys_write+0x116/0x250 [ 1112.740563] ? __ia32_sys_read+0xc0/0xc0 [ 1112.745764] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.751354] ? rcu_is_watching+0x15/0xd0 [ 1112.756559] do_syscall_64+0xf3/0x650 [ 1112.761466] ? trace_hardirqs_off+0xd/0x30 [ 1112.766861] ? exc_page_fault+0xda/0xf0 [ 1112.771964] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.778434] RIP: 0033:0x7f03f09ae22e [ 1112.783244] RSP: 002b:00007fff43769ea0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.792532] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f03f09ae22e [ 1112.801340] RDX: 0000000000000001 RSI: 0000556d9e586e90 RDI: 0000000000000007 [ 1112.810149] RBP: 00007fff43769eb0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.818958] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f03f0826390 [ 1112.827766] R13: 0000556d9e586e90 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.255604] #2: ff11000111ad4b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.266766] #3: ff11000111a81d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.266782] 3 locks held by 9/6830: | [ 1113.266787] | [ 1113.284074] =============================================\x0a [ 1235.439357] INFO: task python3:5776 blocked for more than 368 seconds. [ 1235.447508] Not tainted 7.1.0-rc6-fxsj-gd1384a325c14 #1 [ 1235.454748] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.464338] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080002 [ 1235.477547] Call Trace: [ 1235.481087] [ 1235.484242] __schedule+0xcc3/0x19c0 [ 1235.489060] ? io_schedule_timeout+0x140/0x140 [ 1235.494846] ? find_held_lock+0x2b/0x80 [ 1235.499952] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.505837] schedule+0xd8/0x260 [ 1235.510258] schedule_preempt_disabled+0x18/0x30 [ 1235.516239] __mutex_lock+0x6af/0x2010 [ 1235.521242] ? threaded_store+0x132/0x220 [ 1235.526543] ? ww_mutex_lock+0x160/0x160 [ 1235.531742] ? selinux_inode_free_security+0x330/0x330 [ 1235.538310] ? cap_capable+0x1d6/0x3e0 [ 1235.543320] ? threaded_store+0x132/0x220 [ 1235.548615] threaded_store+0x132/0x220 [ 1235.553716] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.559013] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.564316] ? sysfs_kf_write+0x65/0x160 [ 1235.569519] ? sysfs_file_ops+0x140/0x140 [ 1235.574815] kernfs_fop_write_iter+0x335/0x510 [ 1235.580603] ? kernfs_ops+0xf0/0xf0 [ 1235.585314] new_sync_write+0x333/0x750 [ 1235.590419] ? __lock_acquire+0x508/0xc10 [ 1235.595709] ? new_sync_read+0x740/0x740 [ 1235.600912] ? lock_acquire.part.0+0xbc/0x260 [ 1235.606598] ? ksys_write+0x116/0x250 [ 1235.611506] vfs_write+0x657/0x9b0 [ 1235.616114] ksys_write+0x116/0x250 [ 1235.620825] ? __ia32_sys_read+0xc0/0xc0 [ 1235.626022] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.631613] ? rcu_is_watching+0x15/0xd0 [ 1235.636819] do_syscall_64+0xf3/0x650 [ 1235.641727] ? trace_hardirqs_off+0xd/0x30 [ 1235.647122] ? exc_page_fault+0xda/0xf0 [ 1235.652225] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.658695] RIP: 0033:0x7f03f09ae22e [ 1235.663505] RSP: 002b:00007fff43769ea0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.672793] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f03f09ae22e [ 1235.681594] RDX: 0000000000000001 RSI: 0000556d9e586e90 RDI: 0000000000000007 [ 1235.690403] RBP: 00007fff43769eb0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.699212] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f03f0826390 [ 1235.708022] R13: 0000556d9e586e90 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.113649] #1: ff110001e7bc3880 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.124610] #2: ff11000111ad4b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.135765] #3: ff11000111a81d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.145859] | [ 1236.148324] =============================================\x0a [ 1358.321644] INFO: task python3:5776 blocked for more than 491 seconds. [ 1358.329799] Not tainted 7.1.0-rc6-fxsj-gd1384a325c14 #1 [ 1358.337050] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.346642] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080002 [ 1358.359916] Call Trace: [ 1358.363454] [ 1358.366607] __schedule+0xcc3/0x19c0 [ 1358.371489] ? io_schedule_timeout+0x140/0x140 [ 1358.377275] ? find_held_lock+0x2b/0x80 [ 1358.382384] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.388286] schedule+0xd8/0x260 [ 1358.392710] schedule_preempt_disabled+0x18/0x30 [ 1358.398691] __mutex_lock+0x6af/0x2010 [ 1358.403694] ? threaded_store+0x132/0x220 [ 1358.408988] ? ww_mutex_lock+0x160/0x160 [ 1358.414249] ? selinux_inode_free_security+0x330/0x330 [ 1358.420817] ? cap_capable+0x1d6/0x3e0 [ 1358.425828] ? threaded_store+0x132/0x220 [ 1358.431124] threaded_store+0x132/0x220 [ 1358.436229] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.441526] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.446829] ? sysfs_kf_write+0x65/0x160 [ 1358.452029] ? sysfs_file_ops+0x140/0x140 [ 1358.457377] kernfs_fop_write_iter+0x335/0x510 [ 1358.463164] ? kernfs_ops+0xf0/0xf0 [ 1358.467877] new_sync_write+0x333/0x750 [ 1358.472978] ? __lock_acquire+0x508/0xc10 [ 1358.478274] ? new_sync_read+0x740/0x740 [ 1358.483472] ? lock_acquire.part.0+0xbc/0x260 [ 1358.489846] ? ksys_write+0x116/0x250 [ 1358.494756] vfs_write+0x657/0x9b0 [ 1358.499436] ksys_write+0x116/0x250 [ 1358.504148] ? __ia32_sys_read+0xc0/0xc0 [ 1358.509347] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.514936] ? rcu_is_watching+0x15/0xd0 [ 1358.520129] do_syscall_64+0xf3/0x650 [ 1358.525035] ? trace_hardirqs_off+0xd/0x30 [ 1358.530488] ? exc_page_fault+0xda/0xf0 [ 1358.535587] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.542054] RIP: 0033:0x7f03f09ae22e [ 1358.546856] RSP: 002b:00007fff43769ea0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.556156] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f03f09ae22e [ 1358.564963] RDX: 0000000000000001 RSI: 0000556d9e586e90 RDI: 0000000000000007 [ 1358.573768] RBP: 00007fff43769eb0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.582575] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f03f0826390 [ 1358.591381] R13: 0000556d9e586e90 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store