====================================== | [ 788.670888] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 788.673452] nipa-hw-worker: [5/43] Retrying drivers/net:napi_threaded.py | [ 788.821306] kselftest: Running tests in drivers/net [ 989.692762] INFO: task python3:5840 blocked for more than 122 seconds. [ 989.700975] Not tainted 7.1.0-rc1-kkmz-g8b203681ba40 #1 [ 989.708727] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.718317] task:python3 state:D stack:25032 pid:5840 tgid:5840 ppid:5839 task_flags:0x400100 flags:0x00080000 [ 989.731514] Call Trace: [ 989.735055] [ 989.738205] __schedule+0xcba/0x1940 [ 989.743026] ? io_schedule_timeout+0x140/0x140 [ 989.748811] ? find_held_lock+0x2b/0x80 [ 989.753916] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.759795] schedule+0xd4/0x260 [ 989.764213] schedule_preempt_disabled+0x18/0x30 [ 989.770192] __mutex_lock+0x6a3/0x2000 [ 989.775196] ? threaded_store+0x132/0x220 [ 989.780487] ? ww_mutex_lock+0x160/0x160 [ 989.785687] ? selinux_inode_free_security+0x330/0x330 [ 989.792260] ? cap_capable+0x1d6/0x3e0 [ 989.797270] ? threaded_store+0x132/0x220 [ 989.802571] threaded_store+0x132/0x220 [ 989.807675] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.812974] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.818273] ? sysfs_kf_write+0x65/0x160 [ 989.823474] ? sysfs_file_ops+0x140/0x140 [ 989.828770] kernfs_fop_write_iter+0x335/0x510 [ 989.834556] ? kernfs_ops+0xf0/0xf0 [ 989.839259] new_sync_write+0x333/0x750 [ 989.844361] ? __lock_acquire+0x508/0xc10 [ 989.849658] ? new_sync_read+0x740/0x740 [ 989.854859] ? lock_acquire.part.0+0xbc/0x260 [ 989.860548] ? ksys_write+0x116/0x250 [ 989.865458] vfs_write+0x657/0x9b0 [ 989.870072] ksys_write+0x116/0x250 [ 989.874783] ? __ia32_sys_read+0xc0/0xc0 [ 989.879982] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.885570] ? rcu_is_watching+0x15/0xd0 [ 989.890772] do_syscall_64+0xf3/0x650 [ 989.895679] ? trace_hardirqs_off+0xd/0x30 [ 989.901068] ? exc_page_fault+0xda/0xf0 [ 989.906172] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.912638] RIP: 0033:0x7fef9095a22e [ 989.917447] RSP: 002b:00007fffa56e7fe0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.926738] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fef9095a22e [ 989.935546] RDX: 0000000000000001 RSI: 000055a415b2ea10 RDI: 0000000000000007 [ 989.944345] RBP: 00007fffa56e7ff0 R08: 0000000000000000 R09: 0000000000000000 [ 989.953144] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fef907d2390 [ 989.961941] R13: 000055a415b2ea10 R14: 0000000000000007 R15: 0000000000000003 | [ 990.365379] #1: ff1100020bf66e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.376332] #2: ff11000123374b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.387491] #3: ff110001233b9d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.397578] | [ 990.400046] =============================================\x0a [ 1112.574978] INFO: task python3:5840 blocked for more than 245 seconds. [ 1112.583125] Not tainted 7.1.0-rc1-kkmz-g8b203681ba40 #1 [ 1112.590368] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.599959] task:python3 state:D stack:25032 pid:5840 tgid:5840 ppid:5839 task_flags:0x400100 flags:0x00080000 [ 1112.613162] Call Trace: [ 1112.616702] [ 1112.619850] __schedule+0xcba/0x1940 [ 1112.624664] ? io_schedule_timeout+0x140/0x140 [ 1112.630450] ? find_held_lock+0x2b/0x80 [ 1112.635557] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.641441] schedule+0xd4/0x260 [ 1112.645848] schedule_preempt_disabled+0x18/0x30 [ 1112.651826] __mutex_lock+0x6a3/0x2000 [ 1112.656828] ? threaded_store+0x132/0x220 [ 1112.662126] ? ww_mutex_lock+0x160/0x160 [ 1112.667325] ? selinux_inode_free_security+0x330/0x330 [ 1112.673895] ? cap_capable+0x1d6/0x3e0 [ 1112.678904] ? threaded_store+0x132/0x220 [ 1112.684198] threaded_store+0x132/0x220 [ 1112.689298] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.694595] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.699894] ? sysfs_kf_write+0x65/0x160 [ 1112.705092] ? sysfs_file_ops+0x140/0x140 [ 1112.710384] kernfs_fop_write_iter+0x335/0x510 [ 1112.716167] ? kernfs_ops+0xf0/0xf0 [ 1112.720875] new_sync_write+0x333/0x750 [ 1112.725977] ? __lock_acquire+0x508/0xc10 [ 1112.731274] ? new_sync_read+0x740/0x740 [ 1112.736472] ? lock_acquire.part.0+0xbc/0x260 [ 1112.742159] ? ksys_write+0x116/0x250 [ 1112.747068] vfs_write+0x657/0x9b0 [ 1112.751682] ksys_write+0x116/0x250 [ 1112.756391] ? __ia32_sys_read+0xc0/0xc0 [ 1112.761589] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.767176] ? rcu_is_watching+0x15/0xd0 [ 1112.772377] do_syscall_64+0xf3/0x650 [ 1112.777284] ? trace_hardirqs_off+0xd/0x30 [ 1112.782676] ? exc_page_fault+0xda/0xf0 [ 1112.787780] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.794247] RIP: 0033:0x7fef9095a22e [ 1112.799054] RSP: 002b:00007fffa56e7fe0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.808349] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fef9095a22e [ 1112.817156] RDX: 0000000000000001 RSI: 000055a415b2ea10 RDI: 0000000000000007 [ 1112.825962] RBP: 00007fffa56e7ff0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.834767] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fef907d2390 [ 1112.843573] R13: 000055a415b2ea10 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.279656] #2: ffffffff9cf69c20 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 1113.290327] #3: ffffffff9cd68970 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x6b0 | [ 1113.301970] #4: ffffffff9cf69990 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x6b0 | [ 1113.314396] | [ 1113.316862] =============================================\x0a [ 1235.455215] INFO: task python3:5840 blocked for more than 368 seconds. [ 1235.463363] Not tainted 7.1.0-rc1-kkmz-g8b203681ba40 #1 [ 1235.470615] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.480202] task:python3 state:D stack:25032 pid:5840 tgid:5840 ppid:5839 task_flags:0x400100 flags:0x00080002 [ 1235.493406] Call Trace: [ 1235.496946] [ 1235.500094] __schedule+0xcba/0x1940 [ 1235.504908] ? io_schedule_timeout+0x140/0x140 [ 1235.510694] ? find_held_lock+0x2b/0x80 [ 1235.515797] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.521680] schedule+0xd4/0x260 [ 1235.526096] schedule_preempt_disabled+0x18/0x30 [ 1235.532074] __mutex_lock+0x6a3/0x2000 [ 1235.537077] ? threaded_store+0x132/0x220 [ 1235.542366] ? ww_mutex_lock+0x160/0x160 [ 1235.547566] ? selinux_inode_free_security+0x330/0x330 [ 1235.554134] ? cap_capable+0x1d6/0x3e0 [ 1235.559143] ? threaded_store+0x132/0x220 [ 1235.564441] threaded_store+0x132/0x220 [ 1235.569541] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.574841] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.580140] ? sysfs_kf_write+0x65/0x160 [ 1235.585340] ? sysfs_file_ops+0x140/0x140 [ 1235.590636] kernfs_fop_write_iter+0x335/0x510 [ 1235.596419] ? kernfs_ops+0xf0/0xf0 [ 1235.601130] new_sync_write+0x333/0x750 [ 1235.606234] ? __lock_acquire+0x508/0xc10 [ 1235.611530] ? new_sync_read+0x740/0x740 [ 1235.616732] ? lock_acquire.part.0+0xbc/0x260 [ 1235.622417] ? ksys_write+0x116/0x250 [ 1235.627327] vfs_write+0x657/0x9b0 [ 1235.631938] ksys_write+0x116/0x250 [ 1235.636651] ? __ia32_sys_read+0xc0/0xc0 [ 1235.641842] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.647429] ? rcu_is_watching+0x15/0xd0 [ 1235.652628] do_syscall_64+0xf3/0x650 [ 1235.657524] ? trace_hardirqs_off+0xd/0x30 [ 1235.662920] ? exc_page_fault+0xda/0xf0 [ 1235.668023] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.674489] RIP: 0033:0x7fef9095a22e [ 1235.679296] RSP: 002b:00007fffa56e7fe0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.688591] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fef9095a22e [ 1235.697397] RDX: 0000000000000001 RSI: 000055a415b2ea10 RDI: 0000000000000007 [ 1235.706201] RBP: 00007fffa56e7ff0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.715007] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fef907d2390 [ 1235.723816] R13: 000055a415b2ea10 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.129289] #1: ff1100020bf66e80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.140251] #2: ff11000123374b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.151407] #3: ff110001233b9d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.161497] | [ 1236.163952] =============================================\x0a [ 1358.336456] INFO: task python3:5840 blocked for more than 491 seconds. [ 1358.344611] Not tainted 7.1.0-rc1-kkmz-g8b203681ba40 #1 [ 1358.351861] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.361452] task:python3 state:D stack:25032 pid:5840 tgid:5840 ppid:5839 task_flags:0x400100 flags:0x00080002 [ 1358.374657] Call Trace: [ 1358.378200] [ 1358.381350] __schedule+0xcba/0x1940 [ 1358.386169] ? io_schedule_timeout+0x140/0x140 [ 1358.391954] ? find_held_lock+0x2b/0x80 [ 1358.397061] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.402948] schedule+0xd4/0x260 [ 1358.407370] schedule_preempt_disabled+0x18/0x30 [ 1358.413351] __mutex_lock+0x6a3/0x2000 [ 1358.418358] ? threaded_store+0x132/0x220 [ 1358.423657] ? ww_mutex_lock+0x160/0x160 [ 1358.428858] ? selinux_inode_free_security+0x330/0x330 [ 1358.435431] ? cap_capable+0x1d6/0x3e0 [ 1358.440504] ? threaded_store+0x132/0x220 [ 1358.445802] threaded_store+0x132/0x220 [ 1358.450907] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.456208] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.461506] ? sysfs_kf_write+0x65/0x160 [ 1358.466704] ? sysfs_file_ops+0x140/0x140 [ 1358.471999] kernfs_fop_write_iter+0x335/0x510 [ 1358.477784] ? kernfs_ops+0xf0/0xf0 [ 1358.482494] new_sync_write+0x333/0x750 [ 1358.487597] ? __lock_acquire+0x508/0xc10 [ 1358.492894] ? new_sync_read+0x740/0x740 [ 1358.498092] ? lock_acquire.part.0+0xbc/0x260 [ 1358.503779] ? ksys_write+0x116/0x250 [ 1358.508690] vfs_write+0x657/0x9b0 [ 1358.513314] ksys_write+0x116/0x250 [ 1358.518027] ? __ia32_sys_read+0xc0/0xc0 [ 1358.523226] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.528814] ? rcu_is_watching+0x15/0xd0 [ 1358.534020] do_syscall_64+0xf3/0x650 [ 1358.538993] ? trace_hardirqs_off+0xd/0x30 [ 1358.544389] ? exc_page_fault+0xda/0xf0 [ 1358.549494] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.555961] RIP: 0033:0x7fef9095a22e [ 1358.560762] RSP: 002b:00007fffa56e7fe0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.570063] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fef9095a22e [ 1358.578871] RDX: 0000000000000001 RSI: 000055a415b2ea10 RDI: 0000000000000007 [ 1358.587672] RBP: 00007fffa56e7ff0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.596479] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fef907d2390 [ 1358.605286] R13: 000055a415b2ea10 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store