====================================== | [ 769.614907] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 769.617611] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 769.769769] kselftest: Running tests in drivers/net [ 989.677524] INFO: task python3:5488 blocked for more than 122 seconds. [ 989.685752] Not tainted 7.1.0-rc7-gbwd-g5a4d7108effe #1 [ 989.693645] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.703234] task:python3 state:D stack:25672 pid:5488 tgid:5488 ppid:5487 task_flags:0x400100 flags:0x00080000 [ 989.716439] Call Trace: [ 989.719976] [ 989.723127] __schedule+0xcc3/0x19c0 [ 989.727944] ? io_schedule_timeout+0x140/0x140 [ 989.733725] ? find_held_lock+0x2b/0x80 [ 989.738827] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.744782] schedule+0xd8/0x260 [ 989.749202] schedule_preempt_disabled+0x18/0x30 [ 989.755174] __mutex_lock+0x6af/0x2010 [ 989.760178] ? threaded_store+0x132/0x220 [ 989.765466] ? ww_mutex_lock+0x160/0x160 [ 989.770663] ? selinux_inode_free_security+0x330/0x330 [ 989.777231] ? cap_capable+0x1d6/0x3e0 [ 989.782240] ? threaded_store+0x132/0x220 [ 989.787539] threaded_store+0x132/0x220 [ 989.792643] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.797936] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.803232] ? sysfs_kf_write+0x65/0x160 [ 989.808430] ? sysfs_file_ops+0x140/0x140 [ 989.813723] kernfs_fop_write_iter+0x335/0x510 [ 989.819505] ? kernfs_ops+0xf0/0xf0 [ 989.824216] new_sync_write+0x333/0x750 [ 989.829309] ? __lock_acquire+0x508/0xc10 [ 989.834680] ? new_sync_read+0x740/0x740 [ 989.839882] ? lock_acquire.part.0+0xbc/0x260 [ 989.845565] ? ksys_write+0x116/0x250 [ 989.850474] vfs_write+0x657/0x9b0 [ 989.855087] ksys_write+0x116/0x250 [ 989.859797] ? __ia32_sys_read+0xc0/0xc0 [ 989.864996] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.870582] ? rcu_is_watching+0x15/0xd0 [ 989.875786] do_syscall_64+0xf3/0x650 [ 989.880694] ? trace_hardirqs_off+0xd/0x30 [ 989.886090] ? exc_page_fault+0xda/0xf0 [ 989.891191] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.897656] RIP: 0033:0x7fd11ede164e [ 989.902463] RSP: 002b:00007ffdc29cf1e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.911759] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd11ede164e [ 989.920567] RDX: 0000000000000001 RSI: 0000562213ab7bf0 RDI: 0000000000000007 [ 989.929372] RBP: 00007ffdc29cf1f0 R08: 0000000000000000 R09: 0000000000000000 [ 989.938178] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd11ec5a390 [ 989.946988] R13: 0000562213ab7bf0 R14: 0000000000000007 R15: 00007fd11ebed120 | [ 990.329659] #2: ff11000123acab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.340817] #3: ff11000123a81e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.350905] 1 lock held by systemd/6157: | [ 990.356107] | [ 990.358576] =============================================\x0a [ 1112.558644] INFO: task python3:5488 blocked for more than 245 seconds. [ 1112.566794] Not tainted 7.1.0-rc7-gbwd-g5a4d7108effe #1 [ 1112.574042] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.583626] task:python3 state:D stack:25672 pid:5488 tgid:5488 ppid:5487 task_flags:0x400100 flags:0x00080000 [ 1112.596833] Call Trace: [ 1112.600376] [ 1112.603525] __schedule+0xcc3/0x19c0 [ 1112.608341] ? io_schedule_timeout+0x140/0x140 [ 1112.614125] ? find_held_lock+0x2b/0x80 [ 1112.619219] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.625105] schedule+0xd8/0x260 [ 1112.629525] schedule_preempt_disabled+0x18/0x30 [ 1112.635494] __mutex_lock+0x6af/0x2010 [ 1112.640500] ? threaded_store+0x132/0x220 [ 1112.645800] ? ww_mutex_lock+0x160/0x160 [ 1112.651001] ? selinux_inode_free_security+0x330/0x330 [ 1112.657572] ? cap_capable+0x1d6/0x3e0 [ 1112.662580] ? threaded_store+0x132/0x220 [ 1112.667875] threaded_store+0x132/0x220 [ 1112.672977] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.678268] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.683570] ? sysfs_kf_write+0x65/0x160 [ 1112.688771] ? sysfs_file_ops+0x140/0x140 [ 1112.694065] kernfs_fop_write_iter+0x335/0x510 [ 1112.699851] ? kernfs_ops+0xf0/0xf0 [ 1112.704563] new_sync_write+0x333/0x750 [ 1112.709666] ? __lock_acquire+0x508/0xc10 [ 1112.714963] ? new_sync_read+0x740/0x740 [ 1112.720154] ? lock_acquire.part.0+0xbc/0x260 [ 1112.725838] ? ksys_write+0x116/0x250 [ 1112.730749] vfs_write+0x657/0x9b0 [ 1112.735364] ksys_write+0x116/0x250 [ 1112.740065] ? __ia32_sys_read+0xc0/0xc0 [ 1112.745264] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.750852] ? rcu_is_watching+0x15/0xd0 [ 1112.756053] do_syscall_64+0xf3/0x650 [ 1112.760958] ? trace_hardirqs_off+0xd/0x30 [ 1112.766352] ? exc_page_fault+0xda/0xf0 [ 1112.771456] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.777925] RIP: 0033:0x7fd11ede164e [ 1112.782733] RSP: 002b:00007ffdc29cf1e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.792035] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd11ede164e [ 1112.800843] RDX: 0000000000000001 RSI: 0000562213ab7bf0 RDI: 0000000000000007 [ 1112.809650] RBP: 00007ffdc29cf1f0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.818448] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd11ec5a390 [ 1112.827259] R13: 0000562213ab7bf0 R14: 0000000000000007 R15: 00007fd11ebed120 | [ 1113.227214] #1: ff110001b1555c80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.238178] #2: ff11000123acab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.249334] #3: ff11000123a81e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.259426] | [ 1113.261894] =============================================\x0a [ 1235.439769] INFO: task python3:5488 blocked for more than 368 seconds. [ 1235.447918] Not tainted 7.1.0-rc7-gbwd-g5a4d7108effe #1 [ 1235.455169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.464759] task:python3 state:D stack:25672 pid:5488 tgid:5488 ppid:5487 task_flags:0x400100 flags:0x00080002 [ 1235.477966] Call Trace: [ 1235.481508] [ 1235.484661] __schedule+0xcc3/0x19c0 [ 1235.489481] ? io_schedule_timeout+0x140/0x140 [ 1235.495269] ? find_held_lock+0x2b/0x80 [ 1235.500376] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.506261] schedule+0xd8/0x260 [ 1235.510680] schedule_preempt_disabled+0x18/0x30 [ 1235.516658] __mutex_lock+0x6af/0x2010 [ 1235.521664] ? threaded_store+0x132/0x220 [ 1235.526963] ? ww_mutex_lock+0x160/0x160 [ 1235.532154] ? selinux_inode_free_security+0x330/0x330 [ 1235.538726] ? cap_capable+0x1d6/0x3e0 [ 1235.543737] ? threaded_store+0x132/0x220 [ 1235.549032] threaded_store+0x132/0x220 [ 1235.554133] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.559432] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.564733] ? sysfs_kf_write+0x65/0x160 [ 1235.569934] ? sysfs_file_ops+0x140/0x140 [ 1235.575232] kernfs_fop_write_iter+0x335/0x510 [ 1235.581016] ? kernfs_ops+0xf0/0xf0 [ 1235.585728] new_sync_write+0x333/0x750 [ 1235.590834] ? __lock_acquire+0x508/0xc10 [ 1235.596131] ? new_sync_read+0x740/0x740 [ 1235.601331] ? lock_acquire.part.0+0xbc/0x260 [ 1235.607019] ? ksys_write+0x116/0x250 [ 1235.611928] vfs_write+0x657/0x9b0 [ 1235.616545] ksys_write+0x116/0x250 [ 1235.621259] ? __ia32_sys_read+0xc0/0xc0 [ 1235.626456] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.632046] ? rcu_is_watching+0x15/0xd0 [ 1235.637248] do_syscall_64+0xf3/0x650 [ 1235.642157] ? trace_hardirqs_off+0xd/0x30 [ 1235.647554] ? exc_page_fault+0xda/0xf0 [ 1235.652657] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.659124] RIP: 0033:0x7fd11ede164e [ 1235.663935] RSP: 002b:00007ffdc29cf1e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.673233] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd11ede164e [ 1235.682040] RDX: 0000000000000001 RSI: 0000562213ab7bf0 RDI: 0000000000000007 [ 1235.690847] RBP: 00007ffdc29cf1f0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.699654] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd11ec5a390 [ 1235.708462] R13: 0000562213ab7bf0 R14: 0000000000000007 R15: 00007fd11ebed120 | [ 1236.079752] #1: ff110001b1555c80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.090715] #2: ff11000123acab50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.101873] #3: ff11000123a81e00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.111968] | [ 1236.114435] =============================================\x0a [ 1358.320901] INFO: task python3:5488 blocked for more than 491 seconds. [ 1358.329582] Not tainted 7.1.0-rc7-gbwd-g5a4d7108effe #1 [ 1358.336842] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.346432] task:python3 state:D stack:25672 pid:5488 tgid:5488 ppid:5487 task_flags:0x400100 flags:0x00080002 [ 1358.359646] Call Trace: [ 1358.363276] [ 1358.366427] __schedule+0xcc3/0x19c0 [ 1358.371243] ? io_schedule_timeout+0x140/0x140 [ 1358.377028] ? find_held_lock+0x2b/0x80 [ 1358.382129] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.388012] schedule+0xd8/0x260 [ 1358.392427] schedule_preempt_disabled+0x18/0x30 [ 1358.398407] __mutex_lock+0x6af/0x2010 [ 1358.403404] ? threaded_store+0x132/0x220 [ 1358.408700] ? ww_mutex_lock+0x160/0x160 [ 1358.413898] ? selinux_inode_free_security+0x330/0x330 [ 1358.420458] ? cap_capable+0x1d6/0x3e0 [ 1358.425466] ? threaded_store+0x132/0x220 [ 1358.430762] threaded_store+0x132/0x220 [ 1358.435860] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.441154] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.446450] ? sysfs_kf_write+0x65/0x160 [ 1358.451650] ? sysfs_file_ops+0x140/0x140 [ 1358.456946] kernfs_fop_write_iter+0x335/0x510 [ 1358.462728] ? kernfs_ops+0xf0/0xf0 [ 1358.467439] new_sync_write+0x333/0x750 [ 1358.472543] ? __lock_acquire+0x508/0xc10 [ 1358.477837] ? new_sync_read+0x740/0x740 [ 1358.483037] ? lock_acquire.part.0+0xbc/0x260 [ 1358.488725] ? ksys_write+0x116/0x250 [ 1358.493634] vfs_write+0x657/0x9b0 [ 1358.498249] ksys_write+0x116/0x250 [ 1358.502952] ? __ia32_sys_read+0xc0/0xc0 [ 1358.508148] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.513741] ? rcu_is_watching+0x15/0xd0 [ 1358.518941] do_syscall_64+0xf3/0x650 [ 1358.523838] ? trace_hardirqs_off+0xd/0x30 [ 1358.529231] ? exc_page_fault+0xda/0xf0 [ 1358.534329] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.540794] RIP: 0033:0x7fd11ede164e [ 1358.545605] RSP: 002b:00007ffdc29cf1e0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.554902] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd11ede164e [ 1358.563702] RDX: 0000000000000001 RSI: 0000562213ab7bf0 RDI: 0000000000000007 [ 1358.572506] RBP: 00007ffdc29cf1f0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.581310] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fd11ec5a390 [ 1358.590114] R13: 0000562213ab7bf0 R14: 0000000000000007 R15: 00007fd11ebed120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store