====================================== | [ 788.321813] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 788.324492] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 788.509229] kselftest: Running tests in drivers/net [ 989.728515] INFO: task python3:5776 blocked for more than 122 seconds. [ 989.736736] Not tainted 7.1.0-rc4-qdow-gee3fc64eae7f #1 [ 989.744474] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.754063] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080000 [ 989.767266] Call Trace: [ 989.770806] [ 989.773955] __schedule+0xcc3/0x19c0 [ 989.778771] ? io_schedule_timeout+0x140/0x140 [ 989.784553] ? find_held_lock+0x2b/0x80 [ 989.789657] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.795544] schedule+0xd8/0x260 [ 989.799962] schedule_preempt_disabled+0x18/0x30 [ 989.805938] __mutex_lock+0x6af/0x2010 [ 989.810941] ? threaded_store+0x132/0x220 [ 989.816231] ? ww_mutex_lock+0x160/0x160 [ 989.821427] ? selinux_inode_free_security+0x330/0x330 [ 989.827994] ? cap_capable+0x1d6/0x3e0 [ 989.833000] ? threaded_store+0x132/0x220 [ 989.838287] threaded_store+0x132/0x220 [ 989.843391] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.848685] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.853983] ? sysfs_kf_write+0x65/0x160 [ 989.859180] ? sysfs_file_ops+0x140/0x140 [ 989.864473] kernfs_fop_write_iter+0x335/0x510 [ 989.870257] ? kernfs_ops+0xf0/0xf0 [ 989.874969] new_sync_write+0x333/0x750 [ 989.880070] ? __lock_acquire+0x508/0xc10 [ 989.885367] ? new_sync_read+0x740/0x740 [ 989.890558] ? lock_acquire.part.0+0xbc/0x260 [ 989.896241] ? ksys_write+0x116/0x250 [ 989.901152] vfs_write+0x657/0x9b0 [ 989.905765] ksys_write+0x116/0x250 [ 989.910475] ? __ia32_sys_read+0xc0/0xc0 [ 989.915674] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.921263] ? rcu_is_watching+0x15/0xd0 [ 989.926464] do_syscall_64+0xf3/0x650 [ 989.931371] ? trace_hardirqs_off+0xd/0x30 [ 989.936756] ? exc_page_fault+0xda/0xf0 [ 989.941856] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.948324] RIP: 0033:0x7feaa5af322e [ 989.953133] RSP: 002b:00007ffd24b44760 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.962429] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007feaa5af322e [ 989.971237] RDX: 0000000000000001 RSI: 00005605dd5776b0 RDI: 0000000000000007 [ 989.980033] RBP: 00007ffd24b44770 R08: 0000000000000000 R09: 0000000000000000 [ 989.988840] R10: 0000000000000000 R11: 0000000000000202 R12: 00007feaa596b390 [ 989.997649] R13: 00005605dd5776b0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.379791] #2: ff110001221b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.390940] #3: ff11000122271d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.401026] | [ 990.403490] =============================================\x0a | [ 1100.321583] kworker/u130:1 (224) used greatest stack depth: 21936 bytes left [ 1112.609698] INFO: task python3:5776 blocked for more than 245 seconds. [ 1112.617849] Not tainted 7.1.0-rc4-qdow-gee3fc64eae7f #1 [ 1112.625101] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.634691] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080000 [ 1112.647899] Call Trace: [ 1112.651441] [ 1112.654591] __schedule+0xcc3/0x19c0 [ 1112.659407] ? io_schedule_timeout+0x140/0x140 [ 1112.665192] ? find_held_lock+0x2b/0x80 [ 1112.670296] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.676181] schedule+0xd8/0x260 [ 1112.680599] schedule_preempt_disabled+0x18/0x30 [ 1112.686577] __mutex_lock+0x6af/0x2010 [ 1112.691583] ? threaded_store+0x132/0x220 [ 1112.696883] ? ww_mutex_lock+0x160/0x160 [ 1112.702084] ? selinux_inode_free_security+0x330/0x330 [ 1112.708656] ? cap_capable+0x1d6/0x3e0 [ 1112.713666] ? threaded_store+0x132/0x220 [ 1112.718962] threaded_store+0x132/0x220 [ 1112.724064] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.729366] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.734665] ? sysfs_kf_write+0x65/0x160 [ 1112.739869] ? sysfs_file_ops+0x140/0x140 [ 1112.745166] kernfs_fop_write_iter+0x335/0x510 [ 1112.750950] ? kernfs_ops+0xf0/0xf0 [ 1112.755663] new_sync_write+0x333/0x750 [ 1112.760764] ? __lock_acquire+0x508/0xc10 [ 1112.766061] ? new_sync_read+0x740/0x740 [ 1112.771265] ? lock_acquire.part.0+0xbc/0x260 [ 1112.776952] ? ksys_write+0x116/0x250 [ 1112.781853] vfs_write+0x657/0x9b0 [ 1112.786467] ksys_write+0x116/0x250 [ 1112.791180] ? __ia32_sys_read+0xc0/0xc0 [ 1112.796373] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.801965] ? rcu_is_watching+0x15/0xd0 [ 1112.807166] do_syscall_64+0xf3/0x650 [ 1112.812072] ? trace_hardirqs_off+0xd/0x30 [ 1112.817468] ? exc_page_fault+0xda/0xf0 [ 1112.822563] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.829030] RIP: 0033:0x7feaa5af322e [ 1112.833832] RSP: 002b:00007ffd24b44760 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.843133] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007feaa5af322e [ 1112.851944] RDX: 0000000000000001 RSI: 00005605dd5776b0 RDI: 0000000000000007 [ 1112.860754] RBP: 00007ffd24b44770 R08: 0000000000000000 R09: 0000000000000000 [ 1112.869560] R10: 0000000000000000 R11: 0000000000000202 R12: 00007feaa596b390 [ 1112.878367] R13: 00005605dd5776b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.249684] #1: ff110001efbe6280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.260647] #2: ff110001221b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.271804] #3: ff11000122271d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.281886] | [ 1113.284355] =============================================\x0a [ 1235.490881] INFO: task python3:5776 blocked for more than 368 seconds. [ 1235.499032] Not tainted 7.1.0-rc4-qdow-gee3fc64eae7f #1 [ 1235.506284] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.515872] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080002 [ 1235.529078] Call Trace: [ 1235.532618] [ 1235.535767] __schedule+0xcc3/0x19c0 [ 1235.540584] ? io_schedule_timeout+0x140/0x140 [ 1235.546370] ? find_held_lock+0x2b/0x80 [ 1235.551473] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.557356] schedule+0xd8/0x260 [ 1235.561764] schedule_preempt_disabled+0x18/0x30 [ 1235.567740] __mutex_lock+0x6af/0x2010 [ 1235.572742] ? threaded_store+0x132/0x220 [ 1235.578041] ? ww_mutex_lock+0x160/0x160 [ 1235.583241] ? selinux_inode_free_security+0x330/0x330 [ 1235.589811] ? cap_capable+0x1d6/0x3e0 [ 1235.594822] ? threaded_store+0x132/0x220 [ 1235.600119] threaded_store+0x132/0x220 [ 1235.605220] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.610517] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.615815] ? sysfs_kf_write+0x65/0x160 [ 1235.621012] ? sysfs_file_ops+0x140/0x140 [ 1235.626308] kernfs_fop_write_iter+0x335/0x510 [ 1235.632091] ? kernfs_ops+0xf0/0xf0 [ 1235.636802] new_sync_write+0x333/0x750 [ 1235.641907] ? __lock_acquire+0x508/0xc10 [ 1235.647193] ? new_sync_read+0x740/0x740 [ 1235.652391] ? lock_acquire.part.0+0xbc/0x260 [ 1235.658077] ? ksys_write+0x116/0x250 [ 1235.662987] vfs_write+0x657/0x9b0 [ 1235.667600] ksys_write+0x116/0x250 [ 1235.672315] ? __ia32_sys_read+0xc0/0xc0 [ 1235.677513] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.683100] ? rcu_is_watching+0x15/0xd0 [ 1235.688300] do_syscall_64+0xf3/0x650 [ 1235.693205] ? trace_hardirqs_off+0xd/0x30 [ 1235.698600] ? exc_page_fault+0xda/0xf0 [ 1235.703700] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.710166] RIP: 0033:0x7feaa5af322e [ 1235.714976] RSP: 002b:00007ffd24b44760 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.724272] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007feaa5af322e [ 1235.733077] RDX: 0000000000000001 RSI: 00005605dd5776b0 RDI: 0000000000000007 [ 1235.741883] RBP: 00007ffd24b44770 R08: 0000000000000000 R09: 0000000000000000 [ 1235.750689] R10: 0000000000000000 R11: 0000000000000202 R12: 00007feaa596b390 [ 1235.759495] R13: 00005605dd5776b0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.130667] #1: ff110001efbe6280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.141622] #2: ff110001221b6b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.152776] #3: ff11000122271d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.162865] | [ 1236.165332] =============================================\x0a [ 1358.372075] INFO: task python3:5776 blocked for more than 491 seconds. [ 1358.380223] Not tainted 7.1.0-rc4-qdow-gee3fc64eae7f #1 [ 1358.387476] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.397066] task:python3 state:D stack:25672 pid:5776 tgid:5776 ppid:5775 task_flags:0x400100 flags:0x00080002 [ 1358.410276] Call Trace: [ 1358.410280] [ 1358.410283] __schedule+0xcc3/0x19c0 [ 1358.410295] ? io_schedule_timeout+0x140/0x140 [ 1358.427616] ? find_held_lock+0x2b/0x80 [ 1358.432722] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.438626] schedule+0xd8/0x260 [ 1358.443046] schedule_preempt_disabled+0x18/0x30 [ 1358.449019] __mutex_lock+0x6af/0x2010 [ 1358.454026] ? threaded_store+0x132/0x220 [ 1358.459325] ? ww_mutex_lock+0x160/0x160 [ 1358.464523] ? selinux_inode_free_security+0x330/0x330 [ 1358.471093] ? cap_capable+0x1d6/0x3e0 [ 1358.476101] ? threaded_store+0x132/0x220 [ 1358.481400] threaded_store+0x132/0x220 [ 1358.486501] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.491798] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.497094] ? sysfs_kf_write+0x65/0x160 [ 1358.502296] ? sysfs_file_ops+0x140/0x140 [ 1358.507592] kernfs_fop_write_iter+0x335/0x510 [ 1358.513379] ? kernfs_ops+0xf0/0xf0 [ 1358.518089] new_sync_write+0x333/0x750 [ 1358.523194] ? __lock_acquire+0x508/0xc10 [ 1358.528493] ? new_sync_read+0x740/0x740 [ 1358.533695] ? lock_acquire.part.0+0xbc/0x260 [ 1358.539381] ? ksys_write+0x116/0x250 [ 1358.544291] vfs_write+0x657/0x9b0 [ 1358.548908] ksys_write+0x116/0x250 [ 1358.553623] ? __ia32_sys_read+0xc0/0xc0 [ 1358.558820] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.564410] ? rcu_is_watching+0x15/0xd0 [ 1358.569612] do_syscall_64+0xf3/0x650 [ 1358.574520] ? trace_hardirqs_off+0xd/0x30 [ 1358.579916] ? exc_page_fault+0xda/0xf0 [ 1358.585023] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.591483] RIP: 0033:0x7feaa5af322e [ 1358.596293] RSP: 002b:00007ffd24b44760 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.605592] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007feaa5af322e [ 1358.614402] RDX: 0000000000000001 RSI: 00005605dd5776b0 RDI: 0000000000000007 [ 1358.623211] RBP: 00007ffd24b44770 R08: 0000000000000000 R09: 0000000000000000 [ 1358.632022] R10: 0000000000000000 R11: 0000000000000202 R12: 00007feaa596b390 [ 1358.640830] R13: 00005605dd5776b0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store