====================================== | [ 766.434707] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 766.437324] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 766.570826] kselftest: Running tests in drivers/net [ 989.736217] INFO: task python3:5455 blocked for more than 122 seconds. [ 989.744436] Not tainted 7.1.0-rc7-flzg-gaf33feb37e1f #1 [ 989.752310] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.761900] task:python3 state:D stack:25672 pid:5455 tgid:5455 ppid:5454 task_flags:0x400100 flags:0x00080000 [ 989.775106] Call Trace: [ 989.778643] [ 989.781794] __schedule+0xcc3/0x19c0 [ 989.786612] ? io_schedule_timeout+0x140/0x140 [ 989.792394] ? find_held_lock+0x2b/0x80 [ 989.797500] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.803385] schedule+0xd8/0x260 [ 989.807807] schedule_preempt_disabled+0x18/0x30 [ 989.813786] __mutex_lock+0x6af/0x2010 [ 989.818785] ? threaded_store+0x132/0x220 [ 989.824083] ? ww_mutex_lock+0x160/0x160 [ 989.829277] ? selinux_inode_free_security+0x330/0x330 [ 989.835849] ? cap_capable+0x1d6/0x3e0 [ 989.840942] ? threaded_store+0x132/0x220 [ 989.846237] threaded_store+0x132/0x220 [ 989.851342] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.856640] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.861940] ? sysfs_kf_write+0x65/0x160 [ 989.867142] ? sysfs_file_ops+0x140/0x140 [ 989.872437] kernfs_fop_write_iter+0x335/0x510 [ 989.878220] ? kernfs_ops+0xf0/0xf0 [ 989.882934] new_sync_write+0x333/0x750 [ 989.888039] ? __lock_acquire+0x508/0xc10 [ 989.893327] ? new_sync_read+0x740/0x740 [ 989.898522] ? lock_acquire.part.0+0xbc/0x260 [ 989.904207] ? ksys_write+0x116/0x250 [ 989.909117] vfs_write+0x657/0x9b0 [ 989.913732] ksys_write+0x116/0x250 [ 989.918433] ? __ia32_sys_read+0xc0/0xc0 [ 989.923633] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.929220] ? rcu_is_watching+0x15/0xd0 [ 989.934421] do_syscall_64+0xf3/0x650 [ 989.939328] ? trace_hardirqs_off+0xd/0x30 [ 989.944723] ? exc_page_fault+0xda/0xf0 [ 989.949826] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.956294] RIP: 0033:0x7fa1470a964e [ 989.961103] RSP: 002b:00007ffdb8378d70 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.970403] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa1470a964e [ 989.979213] RDX: 0000000000000001 RSI: 00005572b0e69bf0 RDI: 0000000000000007 [ 989.988023] RBP: 00007ffdb8378d80 R08: 0000000000000000 R09: 0000000000000000 [ 989.996832] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fa146f22390 [ 990.005640] R13: 00005572b0e69bf0 R14: 0000000000000007 R15: 00007fa146eb5120 | [ 990.481104] #2: ffffffff98969c20 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 990.491774] #3: ffffffff987687b0 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x650 | [ 990.503416] #4: ffffffff98969990 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x650 | [ 990.515846] | [ 990.518312] =============================================\x0a [ 1112.618275] INFO: task python3:5455 blocked for more than 245 seconds. [ 1112.626424] Not tainted 7.1.0-rc7-flzg-gaf33feb37e1f #1 [ 1112.633672] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.643254] task:python3 state:D stack:25672 pid:5455 tgid:5455 ppid:5454 task_flags:0x400100 flags:0x00080000 [ 1112.656462] Call Trace: [ 1112.660002] [ 1112.663152] __schedule+0xcc3/0x19c0 [ 1112.667970] ? io_schedule_timeout+0x140/0x140 [ 1112.673757] ? find_held_lock+0x2b/0x80 [ 1112.678864] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.684749] schedule+0xd8/0x260 [ 1112.689167] schedule_preempt_disabled+0x18/0x30 [ 1112.695146] __mutex_lock+0x6af/0x2010 [ 1112.700152] ? threaded_store+0x132/0x220 [ 1112.705450] ? ww_mutex_lock+0x160/0x160 [ 1112.710650] ? selinux_inode_free_security+0x330/0x330 [ 1112.717219] ? cap_capable+0x1d6/0x3e0 [ 1112.722228] ? threaded_store+0x132/0x220 [ 1112.727528] threaded_store+0x132/0x220 [ 1112.732631] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.737929] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.743229] ? sysfs_kf_write+0x65/0x160 [ 1112.748420] ? sysfs_file_ops+0x140/0x140 [ 1112.753717] kernfs_fop_write_iter+0x335/0x510 [ 1112.759495] ? kernfs_ops+0xf0/0xf0 [ 1112.764208] new_sync_write+0x333/0x750 [ 1112.769313] ? __lock_acquire+0x508/0xc10 [ 1112.774601] ? new_sync_read+0x740/0x740 [ 1112.779803] ? lock_acquire.part.0+0xbc/0x260 [ 1112.785491] ? ksys_write+0x116/0x250 [ 1112.790393] vfs_write+0x657/0x9b0 [ 1112.795010] ksys_write+0x116/0x250 [ 1112.799720] ? __ia32_sys_read+0xc0/0xc0 [ 1112.804919] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.810501] ? rcu_is_watching+0x15/0xd0 [ 1112.815705] do_syscall_64+0xf3/0x650 [ 1112.820611] ? trace_hardirqs_off+0xd/0x30 [ 1112.825999] ? exc_page_fault+0xda/0xf0 [ 1112.831102] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.837573] RIP: 0033:0x7fa1470a964e [ 1112.842383] RSP: 002b:00007ffdb8378d70 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.851680] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa1470a964e [ 1112.860481] RDX: 0000000000000001 RSI: 00005572b0e69bf0 RDI: 0000000000000007 [ 1112.869289] RBP: 00007ffdb8378d80 R08: 0000000000000000 R09: 0000000000000000 [ 1112.878089] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fa146f22390 [ 1112.886899] R13: 00005572b0e69bf0 R14: 0000000000000007 R15: 00007fa146eb5120 | [ 1113.263729] #1: ff110001ab626280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.274691] #2: ff11000123464b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.285849] #3: ff110001234d1e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.295938] | [ 1113.298402] =============================================\x0a [ 1235.498347] INFO: task python3:5455 blocked for more than 368 seconds. [ 1235.506499] Not tainted 7.1.0-rc7-flzg-gaf33feb37e1f #1 [ 1235.513750] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.523338] task:python3 state:D stack:25672 pid:5455 tgid:5455 ppid:5454 task_flags:0x400100 flags:0x00080002 [ 1235.536545] Call Trace: [ 1235.540083] [ 1235.543230] __schedule+0xcc3/0x19c0 [ 1235.548048] ? io_schedule_timeout+0x140/0x140 [ 1235.553833] ? find_held_lock+0x2b/0x80 [ 1235.558937] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.564823] schedule+0xd8/0x260 [ 1235.569243] schedule_preempt_disabled+0x18/0x30 [ 1235.575214] __mutex_lock+0x6af/0x2010 [ 1235.580211] ? threaded_store+0x132/0x220 [ 1235.585511] ? ww_mutex_lock+0x160/0x160 [ 1235.590708] ? selinux_inode_free_security+0x330/0x330 [ 1235.597280] ? cap_capable+0x1d6/0x3e0 [ 1235.602285] ? threaded_store+0x132/0x220 [ 1235.607582] threaded_store+0x132/0x220 [ 1235.612678] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.617976] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.623274] ? sysfs_kf_write+0x65/0x160 [ 1235.628474] ? sysfs_file_ops+0x140/0x140 [ 1235.633771] kernfs_fop_write_iter+0x335/0x510 [ 1235.639549] ? kernfs_ops+0xf0/0xf0 [ 1235.644261] new_sync_write+0x333/0x750 [ 1235.649365] ? __lock_acquire+0x508/0xc10 [ 1235.654654] ? new_sync_read+0x740/0x740 [ 1235.659854] ? lock_acquire.part.0+0xbc/0x260 [ 1235.665540] ? ksys_write+0x116/0x250 [ 1235.670450] vfs_write+0x657/0x9b0 [ 1235.675064] ksys_write+0x116/0x250 [ 1235.679777] ? __ia32_sys_read+0xc0/0xc0 [ 1235.684964] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.690554] ? rcu_is_watching+0x15/0xd0 [ 1235.695754] do_syscall_64+0xf3/0x650 [ 1235.700660] ? trace_hardirqs_off+0xd/0x30 [ 1235.706055] ? exc_page_fault+0xda/0xf0 [ 1235.711155] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.717623] RIP: 0033:0x7fa1470a964e [ 1235.722430] RSP: 002b:00007ffdb8378d70 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.731728] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa1470a964e [ 1235.740535] RDX: 0000000000000001 RSI: 00005572b0e69bf0 RDI: 0000000000000007 [ 1235.749342] RBP: 00007ffdb8378d80 R08: 0000000000000000 R09: 0000000000000000 [ 1235.758151] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fa146f22390 [ 1235.766959] R13: 00005572b0e69bf0 R14: 0000000000000007 R15: 00007fa146eb5120 | [ 1236.184238] #1: ff110001ab626280 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.195266] #2: ff11000123464b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.206420] #3: ff110001234d1e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.216508] | [ 1236.218972] =============================================\x0a [ 1358.380456] INFO: task python3:5455 blocked for more than 491 seconds. [ 1358.388604] Not tainted 7.1.0-rc7-flzg-gaf33feb37e1f #1 [ 1358.395855] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.405446] task:python3 state:D stack:25672 pid:5455 tgid:5455 ppid:5454 task_flags:0x400100 flags:0x00080002 [ 1358.418654] Call Trace: [ 1358.422195] [ 1358.425349] __schedule+0xcc3/0x19c0 [ 1358.430167] ? io_schedule_timeout+0x140/0x140 [ 1358.435955] ? find_held_lock+0x2b/0x80 [ 1358.441060] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.446945] schedule+0xd8/0x260 [ 1358.451363] schedule_preempt_disabled+0x18/0x30 [ 1358.457343] __mutex_lock+0x6af/0x2010 [ 1358.462347] ? threaded_store+0x132/0x220 [ 1358.467645] ? ww_mutex_lock+0x160/0x160 [ 1358.472836] ? selinux_inode_free_security+0x330/0x330 [ 1358.479405] ? cap_capable+0x1d6/0x3e0 [ 1358.484414] ? threaded_store+0x132/0x220 [ 1358.489711] threaded_store+0x132/0x220 [ 1358.494812] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.500110] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.505410] ? sysfs_kf_write+0x65/0x160 [ 1358.510613] ? sysfs_file_ops+0x140/0x140 [ 1358.515909] kernfs_fop_write_iter+0x335/0x510 [ 1358.521693] ? kernfs_ops+0xf0/0xf0 [ 1358.526404] new_sync_write+0x333/0x750 [ 1358.531509] ? __lock_acquire+0x508/0xc10 [ 1358.536805] ? new_sync_read+0x740/0x740 [ 1358.542008] ? lock_acquire.part.0+0xbc/0x260 [ 1358.547695] ? ksys_write+0x116/0x250 [ 1358.552603] vfs_write+0x657/0x9b0 [ 1358.557219] ksys_write+0x116/0x250 [ 1358.561933] ? __ia32_sys_read+0xc0/0xc0 [ 1358.567133] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.572723] ? rcu_is_watching+0x15/0xd0 [ 1358.577925] do_syscall_64+0xf3/0x650 [ 1358.582833] ? trace_hardirqs_off+0xd/0x30 [ 1358.588227] ? exc_page_fault+0xda/0xf0 [ 1358.593330] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.599799] RIP: 0033:0x7fa1470a964e [ 1358.604610] RSP: 002b:00007ffdb8378d70 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.613907] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa1470a964e [ 1358.622708] RDX: 0000000000000001 RSI: 00005572b0e69bf0 RDI: 0000000000000007 [ 1358.631518] RBP: 00007ffdb8378d80 R08: 0000000000000000 R09: 0000000000000000 [ 1358.640326] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fa146f22390 [ 1358.649126] R13: 00005572b0e69bf0 R14: 0000000000000007 R15: 00007fa146eb5120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store