====================================== | [ 783.349032] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 783.351467] nipa-hw-worker: [5/46] Retrying drivers/net:napi_threaded.py | [ 783.506653] kselftest: Running tests in drivers/net [ 989.657783] INFO: task python3:5750 blocked for more than 122 seconds. [ 989.666006] Not tainted 7.1.0-rc2-mlwm-g53a1e78f30ff #1 [ 989.673259] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.683472] task:python3 state:D stack:25576 pid:5750 tgid:5750 ppid:5749 task_flags:0x400100 flags:0x00080000 [ 989.696678] Call Trace: [ 989.700216] [ 989.703367] __schedule+0xcba/0x1940 [ 989.708185] ? io_schedule_timeout+0x140/0x140 [ 989.713969] ? find_held_lock+0x2b/0x80 [ 989.719066] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.724953] schedule+0xd4/0x260 [ 989.729372] schedule_preempt_disabled+0x18/0x30 [ 989.735351] __mutex_lock+0x6a3/0x2000 [ 989.740355] ? threaded_store+0x132/0x220 [ 989.745656] ? ww_mutex_lock+0x160/0x160 [ 989.750858] ? selinux_inode_free_security+0x330/0x330 [ 989.757429] ? cap_capable+0x1d6/0x3e0 [ 989.762436] ? threaded_store+0x132/0x220 [ 989.767733] threaded_store+0x132/0x220 [ 989.772829] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.778126] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.783427] ? sysfs_kf_write+0x65/0x160 [ 989.788626] ? sysfs_file_ops+0x140/0x140 [ 989.793921] kernfs_fop_write_iter+0x335/0x510 [ 989.799707] ? kernfs_ops+0xf0/0xf0 [ 989.804412] new_sync_write+0x333/0x750 [ 989.809515] ? __lock_acquire+0x508/0xc10 [ 989.814814] ? new_sync_read+0x740/0x740 [ 989.820014] ? lock_acquire.part.0+0xbc/0x260 [ 989.825700] ? ksys_write+0x116/0x250 [ 989.830617] vfs_write+0x657/0x9b0 [ 989.835232] ksys_write+0x116/0x250 [ 989.839942] ? __ia32_sys_read+0xc0/0xc0 [ 989.845142] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.850731] ? rcu_is_watching+0x15/0xd0 [ 989.855934] do_syscall_64+0xf3/0x650 [ 989.860842] ? trace_hardirqs_off+0xd/0x30 [ 989.866236] ? exc_page_fault+0xda/0xf0 [ 989.871340] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.877807] RIP: 0033:0x7f8a861d322e [ 989.882633] RSP: 002b:00007ffc7ea6dd80 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.891933] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f8a861d322e [ 989.900741] RDX: 0000000000000001 RSI: 000055a0f596efe0 RDI: 0000000000000007 [ 989.909547] RBP: 00007ffc7ea6dd90 R08: 0000000000000000 R09: 0000000000000000 [ 989.918357] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f8a8604b390 [ 989.927166] R13: 000055a0f596efe0 R14: 0000000000000007 R15: 0000000000000003 | [ 990.332761] #1: ff110001f34c5080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.343721] #2: ff110001233c2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.354877] #3: ff11000123409d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.364965] | [ 990.367431] =============================================\x0a [ 1112.538930] INFO: task python3:5750 blocked for more than 245 seconds. [ 1112.547081] Not tainted 7.1.0-rc2-mlwm-g53a1e78f30ff #1 [ 1112.554332] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.563920] task:python3 state:D stack:25576 pid:5750 tgid:5750 ppid:5749 task_flags:0x400100 flags:0x00080000 [ 1112.577128] Call Trace: [ 1112.580669] [ 1112.583819] __schedule+0xcba/0x1940 [ 1112.588638] ? io_schedule_timeout+0x140/0x140 [ 1112.594425] ? find_held_lock+0x2b/0x80 [ 1112.599533] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.605418] schedule+0xd4/0x260 [ 1112.609835] schedule_preempt_disabled+0x18/0x30 [ 1112.615817] __mutex_lock+0x6a3/0x2000 [ 1112.620824] ? threaded_store+0x132/0x220 [ 1112.626122] ? ww_mutex_lock+0x160/0x160 [ 1112.631322] ? selinux_inode_free_security+0x330/0x330 [ 1112.637892] ? cap_capable+0x1d6/0x3e0 [ 1112.642901] ? threaded_store+0x132/0x220 [ 1112.648199] threaded_store+0x132/0x220 [ 1112.653300] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.658598] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.663900] ? sysfs_kf_write+0x65/0x160 [ 1112.669102] ? sysfs_file_ops+0x140/0x140 [ 1112.674399] kernfs_fop_write_iter+0x335/0x510 [ 1112.680182] ? kernfs_ops+0xf0/0xf0 [ 1112.684893] new_sync_write+0x333/0x750 [ 1112.689997] ? __lock_acquire+0x508/0xc10 [ 1112.695293] ? new_sync_read+0x740/0x740 [ 1112.700495] ? lock_acquire.part.0+0xbc/0x260 [ 1112.706183] ? ksys_write+0x116/0x250 [ 1112.711092] vfs_write+0x657/0x9b0 [ 1112.715709] ksys_write+0x116/0x250 [ 1112.720422] ? __ia32_sys_read+0xc0/0xc0 [ 1112.725623] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.731213] ? rcu_is_watching+0x15/0xd0 [ 1112.736419] do_syscall_64+0xf3/0x650 [ 1112.741327] ? trace_hardirqs_off+0xd/0x30 [ 1112.746722] ? exc_page_fault+0xda/0xf0 [ 1112.751823] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.758294] RIP: 0033:0x7f8a861d322e [ 1112.763104] RSP: 002b:00007ffc7ea6dd80 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.772402] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f8a861d322e [ 1112.781210] RDX: 0000000000000001 RSI: 000055a0f596efe0 RDI: 0000000000000007 [ 1112.790019] RBP: 00007ffc7ea6dd90 R08: 0000000000000000 R09: 0000000000000000 [ 1112.798828] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f8a8604b390 [ 1112.807638] R13: 000055a0f596efe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.195448] #2: ff110001233c2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.206608] #3: ff11000123409d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.216698] | [ 1113.219156] =============================================\x0a | [ 1198.556719] kworker/u129:15 (306) used greatest stack depth: 21936 bytes left [ 1235.421115] INFO: task python3:5750 blocked for more than 368 seconds. [ 1235.429265] Not tainted 7.1.0-rc2-mlwm-g53a1e78f30ff #1 [ 1235.436515] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.446106] task:python3 state:D stack:25576 pid:5750 tgid:5750 ppid:5749 task_flags:0x400100 flags:0x00080002 [ 1235.459312] Call Trace: [ 1235.462850] [ 1235.466002] __schedule+0xcba/0x1940 [ 1235.470816] ? io_schedule_timeout+0x140/0x140 [ 1235.476602] ? find_held_lock+0x2b/0x80 [ 1235.481708] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.487590] schedule+0xd4/0x260 [ 1235.492006] schedule_preempt_disabled+0x18/0x30 [ 1235.497987] __mutex_lock+0x6a3/0x2000 [ 1235.502990] ? threaded_store+0x132/0x220 [ 1235.508287] ? ww_mutex_lock+0x160/0x160 [ 1235.513485] ? selinux_inode_free_security+0x330/0x330 [ 1235.520045] ? cap_capable+0x1d6/0x3e0 [ 1235.525053] ? threaded_store+0x132/0x220 [ 1235.530353] threaded_store+0x132/0x220 [ 1235.535453] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.540750] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.546046] ? sysfs_kf_write+0x65/0x160 [ 1235.551246] ? sysfs_file_ops+0x140/0x140 [ 1235.556533] kernfs_fop_write_iter+0x335/0x510 [ 1235.562315] ? kernfs_ops+0xf0/0xf0 [ 1235.567025] new_sync_write+0x333/0x750 [ 1235.572128] ? __lock_acquire+0x508/0xc10 [ 1235.577424] ? new_sync_read+0x740/0x740 [ 1235.582626] ? lock_acquire.part.0+0xbc/0x260 [ 1235.588313] ? ksys_write+0x116/0x250 [ 1235.593222] vfs_write+0x657/0x9b0 [ 1235.597834] ksys_write+0x116/0x250 [ 1235.602546] ? __ia32_sys_read+0xc0/0xc0 [ 1235.607734] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.613320] ? rcu_is_watching+0x15/0xd0 [ 1235.618519] do_syscall_64+0xf3/0x650 [ 1235.623423] ? trace_hardirqs_off+0xd/0x30 [ 1235.628818] ? exc_page_fault+0xda/0xf0 [ 1235.633920] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.640385] RIP: 0033:0x7f8a861d322e [ 1235.645195] RSP: 002b:00007ffc7ea6dd80 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.654485] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f8a861d322e [ 1235.663294] RDX: 0000000000000001 RSI: 000055a0f596efe0 RDI: 0000000000000007 [ 1235.672100] RBP: 00007ffc7ea6dd90 R08: 0000000000000000 R09: 0000000000000000 [ 1235.680905] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f8a8604b390 [ 1235.689710] R13: 000055a0f596efe0 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.066563] #1: ff110001f34c5080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.077523] #2: ff110001233c2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.088680] #3: ff11000123409d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.098764] | [ 1236.101229] =============================================\x0a [ 1358.302315] INFO: task python3:5750 blocked for more than 491 seconds. [ 1358.310464] Not tainted 7.1.0-rc2-mlwm-g53a1e78f30ff #1 [ 1358.317715] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.327308] task:python3 state:D stack:25576 pid:5750 tgid:5750 ppid:5749 task_flags:0x400100 flags:0x00080002 [ 1358.340516] Call Trace: [ 1358.344057] [ 1358.347210] __schedule+0xcba/0x1940 [ 1358.352028] ? io_schedule_timeout+0x140/0x140 [ 1358.357816] ? find_held_lock+0x2b/0x80 [ 1358.362923] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.368808] schedule+0xd4/0x260 [ 1358.373229] schedule_preempt_disabled+0x18/0x30 [ 1358.379211] __mutex_lock+0x6a3/0x2000 [ 1358.384214] ? threaded_store+0x132/0x220 [ 1358.389504] ? ww_mutex_lock+0x160/0x160 [ 1358.394704] ? selinux_inode_free_security+0x330/0x330 [ 1358.401274] ? cap_capable+0x1d6/0x3e0 [ 1358.406292] ? threaded_store+0x132/0x220 [ 1358.411600] threaded_store+0x132/0x220 [ 1358.416707] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.422004] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.427303] ? sysfs_kf_write+0x65/0x160 [ 1358.432504] ? sysfs_file_ops+0x140/0x140 [ 1358.437790] kernfs_fop_write_iter+0x335/0x510 [ 1358.443576] ? kernfs_ops+0xf0/0xf0 [ 1358.448278] new_sync_write+0x333/0x750 [ 1358.453374] ? __lock_acquire+0x508/0xc10 [ 1358.458671] ? new_sync_read+0x740/0x740 [ 1358.463873] ? lock_acquire.part.0+0xbc/0x260 [ 1358.469561] ? ksys_write+0x116/0x250 [ 1358.474465] vfs_write+0x657/0x9b0 [ 1358.479082] ksys_write+0x116/0x250 [ 1358.483796] ? __ia32_sys_read+0xc0/0xc0 [ 1358.488998] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.494588] ? rcu_is_watching+0x15/0xd0 [ 1358.499793] do_syscall_64+0xf3/0x650 [ 1358.504701] ? trace_hardirqs_off+0xd/0x30 [ 1358.510097] ? exc_page_fault+0xda/0xf0 [ 1358.515199] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.521661] RIP: 0033:0x7f8a861d322e [ 1358.526471] RSP: 002b:00007ffc7ea6dd80 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.535760] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f8a861d322e [ 1358.544570] RDX: 0000000000000001 RSI: 000055a0f596efe0 RDI: 0000000000000007 [ 1358.553380] RBP: 00007ffc7ea6dd90 R08: 0000000000000000 R09: 0000000000000000 [ 1358.562189] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f8a8604b390 [ 1358.570998] R13: 000055a0f596efe0 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store