====================================== | [ 780.074412] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 780.076938] nipa-hw-worker: [4/40] Retrying drivers/net:napi_threaded.py | [ 780.229197] kselftest: Running tests in drivers/net [ 989.655268] INFO: task python3:5603 blocked for more than 122 seconds. [ 989.663508] Not tainted 7.0.0-rc6-twpr-ga220ed2c96ca #1 [ 989.670760] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.680352] task:python3 state:D stack:25336 pid:5603 tgid:5603 ppid:5602 task_flags:0x400100 flags:0x00080000 [ 989.693559] Call Trace: [ 989.697098] [ 989.700250] __schedule+0xae3/0x14d0 [ 989.705067] ? io_schedule_timeout+0x140/0x140 [ 989.710858] ? find_held_lock+0x2b/0x80 [ 989.715966] schedule+0xd4/0x260 [ 989.720387] schedule_preempt_disabled+0x18/0x30 [ 989.726366] __mutex_lock+0x6b2/0x1ee0 [ 989.731372] ? rcu_is_watching+0x15/0xd0 [ 989.736569] ? threaded_store+0x132/0x220 [ 989.741868] ? ww_mutex_lock+0x160/0x160 [ 989.747067] ? selinux_inode_free_security+0x330/0x330 [ 989.753642] ? cap_capable+0x1ed/0x3f0 [ 989.758651] ? threaded_store+0x132/0x220 [ 989.763947] threaded_store+0x132/0x220 [ 989.769050] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.774355] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.779652] ? sysfs_kf_write+0x65/0x160 [ 989.784851] ? sysfs_file_ops+0x140/0x140 [ 989.790145] kernfs_fop_write_iter+0x335/0x510 [ 989.795928] ? kernfs_ops+0xf0/0xf0 [ 989.800636] new_sync_write+0x333/0x750 [ 989.805739] ? __lock_acquire+0x508/0xc10 [ 989.811032] ? new_sync_read+0x740/0x740 [ 989.816233] ? lock_acquire.part.0+0xbc/0x260 [ 989.821919] ? ksys_write+0x116/0x250 [ 989.826831] vfs_write+0x657/0x9b0 [ 989.831446] ksys_write+0x116/0x250 [ 989.836149] ? __ia32_sys_read+0xc0/0xc0 [ 989.841346] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.847003] ? rcu_is_watching+0x15/0xd0 [ 989.852200] do_syscall_64+0xf3/0x5e0 [ 989.857106] ? trace_hardirqs_off+0xd/0x30 [ 989.862500] ? exc_page_fault+0xda/0xf0 [ 989.867599] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.874065] RIP: 0033:0x7fd8ceee222e [ 989.878877] RSP: 002b:00007fffe5baae90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.888173] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd8ceee222e [ 989.896981] RDX: 0000000000000001 RSI: 000055a6005b7f40 RDI: 0000000000000007 [ 989.905788] RBP: 00007fffe5baaea0 R08: 0000000000000000 R09: 0000000000000000 [ 989.914595] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd8ced5a390 [ 989.923394] R13: 000055a6005b7f40 R14: 0000000000000007 R15: 0000000000000003 | [ 990.324458] #1: ff110001c10d2c88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.335419] #2: ff110001221dd0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.346574] #3: ff11000122241d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.356666] | [ 990.359131] =============================================\x0a [ 1112.537414] INFO: task python3:5603 blocked for more than 245 seconds. [ 1112.545560] Not tainted 7.0.0-rc6-twpr-ga220ed2c96ca #1 [ 1112.552812] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.562400] task:python3 state:D stack:25336 pid:5603 tgid:5603 ppid:5602 task_flags:0x400100 flags:0x00080000 [ 1112.575605] Call Trace: [ 1112.579146] [ 1112.582300] __schedule+0xae3/0x14d0 [ 1112.587115] ? io_schedule_timeout+0x140/0x140 [ 1112.592903] ? find_held_lock+0x2b/0x80 [ 1112.598015] schedule+0xd4/0x260 [ 1112.602434] schedule_preempt_disabled+0x18/0x30 [ 1112.608405] __mutex_lock+0x6b2/0x1ee0 [ 1112.613412] ? rcu_is_watching+0x15/0xd0 [ 1112.618614] ? threaded_store+0x132/0x220 [ 1112.623915] ? ww_mutex_lock+0x160/0x160 [ 1112.629112] ? selinux_inode_free_security+0x330/0x330 [ 1112.635676] ? cap_capable+0x1ed/0x3f0 [ 1112.640682] ? threaded_store+0x132/0x220 [ 1112.645979] threaded_store+0x132/0x220 [ 1112.651082] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.656382] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.661680] ? sysfs_kf_write+0x65/0x160 [ 1112.666878] ? sysfs_file_ops+0x140/0x140 [ 1112.672173] kernfs_fop_write_iter+0x335/0x510 [ 1112.677959] ? kernfs_ops+0xf0/0xf0 [ 1112.682664] new_sync_write+0x333/0x750 [ 1112.687766] ? __lock_acquire+0x508/0xc10 [ 1112.693065] ? new_sync_read+0x740/0x740 [ 1112.698264] ? lock_acquire.part.0+0xbc/0x260 [ 1112.703950] ? ksys_write+0x116/0x250 [ 1112.708861] vfs_write+0x657/0x9b0 [ 1112.713477] ksys_write+0x116/0x250 [ 1112.718187] ? __ia32_sys_read+0xc0/0xc0 [ 1112.723387] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.728977] ? rcu_is_watching+0x15/0xd0 [ 1112.734179] do_syscall_64+0xf3/0x5e0 [ 1112.739086] ? trace_hardirqs_off+0xd/0x30 [ 1112.744484] ? exc_page_fault+0xda/0xf0 [ 1112.749584] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.756053] RIP: 0033:0x7fd8ceee222e [ 1112.760864] RSP: 002b:00007fffe5baae90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.770165] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd8ceee222e [ 1112.778972] RDX: 0000000000000001 RSI: 000055a6005b7f40 RDI: 0000000000000007 [ 1112.787781] RBP: 00007fffe5baaea0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.796589] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd8ced5a390 [ 1112.805399] R13: 000055a6005b7f40 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.205343] #1: ff110001c10d2c88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.216298] #2: ff110001221dd0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.227456] #3: ff11000122241d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.237547] | [ 1113.240015] =============================================\x0a [ 1235.418576] INFO: task python3:5603 blocked for more than 368 seconds. [ 1235.426722] Not tainted 7.0.0-rc6-twpr-ga220ed2c96ca #1 [ 1235.433962] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.443548] task:python3 state:D stack:25336 pid:5603 tgid:5603 ppid:5602 task_flags:0x400100 flags:0x00080002 [ 1235.456753] Call Trace: [ 1235.460292] [ 1235.463440] __schedule+0xae3/0x14d0 [ 1235.468252] ? io_schedule_timeout+0x140/0x140 [ 1235.474038] ? find_held_lock+0x2b/0x80 [ 1235.479144] schedule+0xd4/0x260 [ 1235.483563] schedule_preempt_disabled+0x18/0x30 [ 1235.489542] __mutex_lock+0x6b2/0x1ee0 [ 1235.494548] ? rcu_is_watching+0x15/0xd0 [ 1235.499746] ? threaded_store+0x132/0x220 [ 1235.505037] ? ww_mutex_lock+0x160/0x160 [ 1235.510233] ? selinux_inode_free_security+0x330/0x330 [ 1235.516800] ? cap_capable+0x1ed/0x3f0 [ 1235.521797] ? threaded_store+0x132/0x220 [ 1235.527093] threaded_store+0x132/0x220 [ 1235.532194] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.537490] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.542785] ? sysfs_kf_write+0x65/0x160 [ 1235.547985] ? sysfs_file_ops+0x140/0x140 [ 1235.553279] kernfs_fop_write_iter+0x335/0x510 [ 1235.559061] ? kernfs_ops+0xf0/0xf0 [ 1235.563770] new_sync_write+0x333/0x750 [ 1235.568874] ? __lock_acquire+0x508/0xc10 [ 1235.574167] ? new_sync_read+0x740/0x740 [ 1235.579366] ? lock_acquire.part.0+0xbc/0x260 [ 1235.585043] ? ksys_write+0x116/0x250 [ 1235.589950] vfs_write+0x657/0x9b0 [ 1235.594562] ksys_write+0x116/0x250 [ 1235.599270] ? __ia32_sys_read+0xc0/0xc0 [ 1235.604469] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.610056] ? rcu_is_watching+0x15/0xd0 [ 1235.615254] do_syscall_64+0xf3/0x5e0 [ 1235.620160] ? trace_hardirqs_off+0xd/0x30 [ 1235.625556] ? exc_page_fault+0xda/0xf0 [ 1235.630660] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.637125] RIP: 0033:0x7fd8ceee222e [ 1235.641934] RSP: 002b:00007fffe5baae90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.651230] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd8ceee222e [ 1235.660036] RDX: 0000000000000001 RSI: 000055a6005b7f40 RDI: 0000000000000007 [ 1235.668844] RBP: 00007fffe5baaea0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.677653] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd8ced5a390 [ 1235.686458] R13: 000055a6005b7f40 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.124312] #2: ff110001221dd0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.135466] #3: ff11000122241d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.145560] | [ 1236.148026] =============================================\x0a | [ 1333.722584] kworker/u129:8 (285) used greatest stack depth: 21192 bytes left [ 1358.299794] INFO: task python3:5603 blocked for more than 491 seconds. [ 1358.307941] Not tainted 7.0.0-rc6-twpr-ga220ed2c96ca #1 [ 1358.315194] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.324784] task:python3 state:D stack:25336 pid:5603 tgid:5603 ppid:5602 task_flags:0x400100 flags:0x00080002 [ 1358.337989] Call Trace: [ 1358.341525] [ 1358.344674] __schedule+0xae3/0x14d0 [ 1358.349487] ? io_schedule_timeout+0x140/0x140 [ 1358.355273] ? find_held_lock+0x2b/0x80 [ 1358.360380] schedule+0xd4/0x260 [ 1358.364815] schedule_preempt_disabled+0x18/0x30 [ 1358.370797] __mutex_lock+0x6b2/0x1ee0 [ 1358.375803] ? rcu_is_watching+0x15/0xd0 [ 1358.381002] ? threaded_store+0x132/0x220 [ 1358.386293] ? ww_mutex_lock+0x160/0x160 [ 1358.391481] ? selinux_inode_free_security+0x330/0x330 [ 1358.398051] ? cap_capable+0x1ed/0x3f0 [ 1358.403056] ? threaded_store+0x132/0x220 [ 1358.408351] threaded_store+0x132/0x220 [ 1358.413454] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.418740] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.424038] ? sysfs_kf_write+0x65/0x160 [ 1358.429237] ? sysfs_file_ops+0x140/0x140 [ 1358.434531] kernfs_fop_write_iter+0x335/0x510 [ 1358.440316] ? kernfs_ops+0xf0/0xf0 [ 1358.445025] new_sync_write+0x333/0x750 [ 1358.450126] ? __lock_acquire+0x508/0xc10 [ 1358.455419] ? new_sync_read+0x740/0x740 [ 1358.460618] ? lock_acquire.part.0+0xbc/0x260 [ 1358.466303] ? ksys_write+0x116/0x250 [ 1358.471213] vfs_write+0x657/0x9b0 [ 1358.475828] ksys_write+0x116/0x250 [ 1358.480531] ? __ia32_sys_read+0xc0/0xc0 [ 1358.485730] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.491311] ? rcu_is_watching+0x15/0xd0 [ 1358.496509] do_syscall_64+0xf3/0x5e0 [ 1358.501413] ? trace_hardirqs_off+0xd/0x30 [ 1358.506807] ? exc_page_fault+0xda/0xf0 [ 1358.511908] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.518376] RIP: 0033:0x7fd8ceee222e [ 1358.523185] RSP: 002b:00007fffe5baae90 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.532483] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd8ceee222e [ 1358.541292] RDX: 0000000000000001 RSI: 000055a6005b7f40 RDI: 0000000000000007 [ 1358.550100] RBP: 00007fffe5baaea0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.558910] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd8ced5a390 [ 1358.567715] R13: 000055a6005b7f40 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store