====================================== | [ 780.434611] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 780.437629] nipa-hw-worker: [5/43] Retrying drivers/net:napi_threaded.py | [ 780.593082] kselftest: Running tests in drivers/net [ 989.701083] INFO: task python3:5723 blocked for more than 122 seconds. [ 989.709284] Not tainted 7.1.0-rc1-rhjl-g59d195f5d845 #1 [ 989.716747] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.726339] task:python3 state:D stack:25672 pid:5723 tgid:5723 ppid:5722 task_flags:0x400100 flags:0x00080000 [ 989.739547] Call Trace: [ 989.743088] [ 989.746242] __schedule+0xcba/0x1940 [ 989.751054] ? io_schedule_timeout+0x140/0x140 [ 989.756840] ? find_held_lock+0x2b/0x80 [ 989.761948] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.767834] schedule+0xd4/0x260 [ 989.772255] schedule_preempt_disabled+0x18/0x30 [ 989.778236] __mutex_lock+0x6a3/0x2000 [ 989.783242] ? threaded_store+0x132/0x220 [ 989.788543] ? ww_mutex_lock+0x160/0x160 [ 989.793742] ? selinux_inode_free_security+0x330/0x330 [ 989.800315] ? cap_capable+0x1d6/0x3e0 [ 989.805326] ? threaded_store+0x132/0x220 [ 989.810624] threaded_store+0x132/0x220 [ 989.815726] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.821022] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.826323] ? sysfs_kf_write+0x65/0x160 [ 989.831521] ? sysfs_file_ops+0x140/0x140 [ 989.836816] kernfs_fop_write_iter+0x335/0x510 [ 989.842601] ? kernfs_ops+0xf0/0xf0 [ 989.847311] new_sync_write+0x333/0x750 [ 989.852415] ? __lock_acquire+0x508/0xc10 [ 989.857705] ? new_sync_read+0x740/0x740 [ 989.862906] ? lock_acquire.part.0+0xbc/0x260 [ 989.868596] ? ksys_write+0x116/0x250 [ 989.873508] vfs_write+0x657/0x9b0 [ 989.878125] ksys_write+0x116/0x250 [ 989.882837] ? __ia32_sys_read+0xc0/0xc0 [ 989.888038] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.893629] ? rcu_is_watching+0x15/0xd0 [ 989.898833] do_syscall_64+0xf3/0x650 [ 989.903740] ? trace_hardirqs_off+0xd/0x30 [ 989.909126] ? exc_page_fault+0xda/0xf0 [ 989.914229] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.920689] RIP: 0033:0x7fb3c396122e [ 989.925498] RSP: 002b:00007ffcdfbdde40 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.934795] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb3c396122e [ 989.943603] RDX: 0000000000000001 RSI: 0000556448e6ba10 RDI: 0000000000000007 [ 989.952412] RBP: 00007ffcdfbdde50 R08: 0000000000000000 R09: 0000000000000000 [ 989.961221] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb3c37d9390 [ 989.970029] R13: 0000556448e6ba10 R14: 0000000000000007 R15: 0000000000000003 | [ 990.346910] #1: ff110001c7af5c80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.357876] #2: ff11000122f16b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.369036] #3: ff11000122f71d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.379127] | [ 990.381594] =============================================\x0a [ 1112.582349] INFO: task python3:5723 blocked for more than 245 seconds. [ 1112.590496] Not tainted 7.1.0-rc1-rhjl-g59d195f5d845 #1 [ 1112.597739] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.607327] task:python3 state:D stack:25672 pid:5723 tgid:5723 ppid:5722 task_flags:0x400100 flags:0x00080000 [ 1112.620533] Call Trace: [ 1112.624075] [ 1112.627225] __schedule+0xcba/0x1940 [ 1112.632040] ? io_schedule_timeout+0x140/0x140 [ 1112.637829] ? find_held_lock+0x2b/0x80 [ 1112.642932] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.648810] schedule+0xd4/0x260 [ 1112.653228] schedule_preempt_disabled+0x18/0x30 [ 1112.659207] __mutex_lock+0x6a3/0x2000 [ 1112.664212] ? threaded_store+0x132/0x220 [ 1112.669512] ? ww_mutex_lock+0x160/0x160 [ 1112.674713] ? selinux_inode_free_security+0x330/0x330 [ 1112.681283] ? cap_capable+0x1d6/0x3e0 [ 1112.686303] ? threaded_store+0x132/0x220 [ 1112.691612] threaded_store+0x132/0x220 [ 1112.696714] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.702013] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.707310] ? sysfs_kf_write+0x65/0x160 [ 1112.712511] ? sysfs_file_ops+0x140/0x140 [ 1112.717808] kernfs_fop_write_iter+0x335/0x510 [ 1112.723591] ? kernfs_ops+0xf0/0xf0 [ 1112.728303] new_sync_write+0x333/0x750 [ 1112.733407] ? __lock_acquire+0x508/0xc10 [ 1112.738705] ? new_sync_read+0x740/0x740 [ 1112.743909] ? lock_acquire.part.0+0xbc/0x260 [ 1112.749596] ? ksys_write+0x116/0x250 [ 1112.754497] vfs_write+0x657/0x9b0 [ 1112.759115] ksys_write+0x116/0x250 [ 1112.763828] ? __ia32_sys_read+0xc0/0xc0 [ 1112.769021] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.774612] ? rcu_is_watching+0x15/0xd0 [ 1112.779816] do_syscall_64+0xf3/0x650 [ 1112.784726] ? trace_hardirqs_off+0xd/0x30 [ 1112.790122] ? exc_page_fault+0xda/0xf0 [ 1112.795226] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.801692] RIP: 0033:0x7fb3c396122e [ 1112.806504] RSP: 002b:00007ffcdfbdde40 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.815802] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb3c396122e [ 1112.824612] RDX: 0000000000000001 RSI: 0000556448e6ba10 RDI: 0000000000000007 [ 1112.833421] RBP: 00007ffcdfbdde50 R08: 0000000000000000 R09: 0000000000000000 [ 1112.842229] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb3c37d9390 [ 1112.851040] R13: 0000556448e6ba10 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.256602] #1: ff110001c7af5c80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.267565] #2: ff11000122f16b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.278723] #3: ff11000122f71d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.288814] | [ 1113.291280] =============================================\x0a [ 1235.463525] INFO: task python3:5723 blocked for more than 368 seconds. [ 1235.471676] Not tainted 7.1.0-rc1-rhjl-g59d195f5d845 #1 [ 1235.478918] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.488504] task:python3 state:D stack:25672 pid:5723 tgid:5723 ppid:5722 task_flags:0x400100 flags:0x00080002 [ 1235.501708] Call Trace: [ 1235.505251] [ 1235.508401] __schedule+0xcba/0x1940 [ 1235.513221] ? io_schedule_timeout+0x140/0x140 [ 1235.519008] ? find_held_lock+0x2b/0x80 [ 1235.524115] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.530001] schedule+0xd4/0x260 [ 1235.534419] schedule_preempt_disabled+0x18/0x30 [ 1235.540397] __mutex_lock+0x6a3/0x2000 [ 1235.545401] ? threaded_store+0x132/0x220 [ 1235.550700] ? ww_mutex_lock+0x160/0x160 [ 1235.555900] ? selinux_inode_free_security+0x330/0x330 [ 1235.562471] ? cap_capable+0x1d6/0x3e0 [ 1235.567482] ? threaded_store+0x132/0x220 [ 1235.572782] threaded_store+0x132/0x220 [ 1235.577882] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.583177] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.588474] ? sysfs_kf_write+0x65/0x160 [ 1235.593672] ? sysfs_file_ops+0x140/0x140 [ 1235.598966] kernfs_fop_write_iter+0x335/0x510 [ 1235.604753] ? kernfs_ops+0xf0/0xf0 [ 1235.609466] new_sync_write+0x333/0x750 [ 1235.614572] ? __lock_acquire+0x508/0xc10 [ 1235.619869] ? new_sync_read+0x740/0x740 [ 1235.625073] ? lock_acquire.part.0+0xbc/0x260 [ 1235.630759] ? ksys_write+0x116/0x250 [ 1235.635669] vfs_write+0x657/0x9b0 [ 1235.640282] ksys_write+0x116/0x250 [ 1235.644995] ? __ia32_sys_read+0xc0/0xc0 [ 1235.650196] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.655787] ? rcu_is_watching+0x15/0xd0 [ 1235.660987] do_syscall_64+0xf3/0x650 [ 1235.665897] ? trace_hardirqs_off+0xd/0x30 [ 1235.671293] ? exc_page_fault+0xda/0xf0 [ 1235.676398] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.682868] RIP: 0033:0x7fb3c396122e [ 1235.687679] RSP: 002b:00007ffcdfbdde40 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.696978] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb3c396122e [ 1235.705788] RDX: 0000000000000001 RSI: 0000556448e6ba10 RDI: 0000000000000007 [ 1235.714598] RBP: 00007ffcdfbdde50 R08: 0000000000000000 R09: 0000000000000000 [ 1235.723405] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb3c37d9390 [ 1235.732206] R13: 0000556448e6ba10 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.137743] #1: ff110001c7af5c80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.148702] #2: ff11000122f16b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.159860] #3: ff11000122f71d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.169950] | [ 1236.172416] =============================================\x0a [ 1358.344473] INFO: task python3:5723 blocked for more than 491 seconds. [ 1358.352623] Not tainted 7.1.0-rc1-rhjl-g59d195f5d845 #1 [ 1358.359874] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.369461] task:python3 state:D stack:25672 pid:5723 tgid:5723 ppid:5722 task_flags:0x400100 flags:0x00080002 [ 1358.382665] Call Trace: [ 1358.386205] [ 1358.389353] __schedule+0xcba/0x1940 [ 1358.394167] ? io_schedule_timeout+0x140/0x140 [ 1358.399954] ? find_held_lock+0x2b/0x80 [ 1358.405056] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.410941] schedule+0xd4/0x260 [ 1358.415358] schedule_preempt_disabled+0x18/0x30 [ 1358.421336] __mutex_lock+0x6a3/0x2000 [ 1358.426339] ? threaded_store+0x132/0x220 [ 1358.431637] ? ww_mutex_lock+0x160/0x160 [ 1358.436833] ? selinux_inode_free_security+0x330/0x330 [ 1358.443404] ? cap_capable+0x1d6/0x3e0 [ 1358.448409] ? threaded_store+0x132/0x220 [ 1358.453703] threaded_store+0x132/0x220 [ 1358.458804] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.464097] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.469396] ? sysfs_kf_write+0x65/0x160 [ 1358.474595] ? sysfs_file_ops+0x140/0x140 [ 1358.479891] kernfs_fop_write_iter+0x335/0x510 [ 1358.485674] ? kernfs_ops+0xf0/0xf0 [ 1358.490386] new_sync_write+0x333/0x750 [ 1358.495487] ? __lock_acquire+0x508/0xc10 [ 1358.500785] ? new_sync_read+0x740/0x740 [ 1358.505987] ? lock_acquire.part.0+0xbc/0x260 [ 1358.511674] ? ksys_write+0x116/0x250 [ 1358.516575] vfs_write+0x657/0x9b0 [ 1358.521189] ksys_write+0x116/0x250 [ 1358.525897] ? __ia32_sys_read+0xc0/0xc0 [ 1358.531096] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.536683] ? rcu_is_watching+0x15/0xd0 [ 1358.541884] do_syscall_64+0xf3/0x650 [ 1358.546791] ? trace_hardirqs_off+0xd/0x30 [ 1358.552183] ? exc_page_fault+0xda/0xf0 [ 1358.557286] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.563743] RIP: 0033:0x7fb3c396122e [ 1358.568550] RSP: 002b:00007ffcdfbdde40 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.577846] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fb3c396122e [ 1358.586653] RDX: 0000000000000001 RSI: 0000556448e6ba10 RDI: 0000000000000007 [ 1358.595459] RBP: 00007ffcdfbdde50 R08: 0000000000000000 R09: 0000000000000000 [ 1358.604267] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fb3c37d9390 [ 1358.613065] R13: 0000556448e6ba10 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store