====================================== | [ 781.653395] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 781.655922] nipa-hw-worker: [4/40] Retrying drivers/net:napi_threaded.py | [ 781.793698] kselftest: Running tests in drivers/net [ 989.714243] INFO: task python3:5440 blocked for more than 122 seconds. [ 989.722473] Not tainted 7.0.0-rc6-qbvg-ga64f8f00fd9b #1 [ 989.729724] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.739314] task:python3 state:D stack:25312 pid:5440 tgid:5440 ppid:5439 task_flags:0x400100 flags:0x00080000 [ 989.752521] Call Trace: [ 989.756063] [ 989.759215] __schedule+0xad9/0x1490 [ 989.764035] ? io_schedule_timeout+0x130/0x130 [ 989.769820] ? find_held_lock+0x2b/0x80 [ 989.774927] ? __lock_release.isra.0+0x59/0x170 [ 989.780813] schedule+0xd4/0x260 [ 989.785231] schedule_preempt_disabled+0x18/0x30 [ 989.791210] __mutex_lock+0xd76/0x1f20 [ 989.796217] ? threaded_store+0x132/0x220 [ 989.801517] ? ww_mutex_lock+0x160/0x160 [ 989.806718] ? selinux_inode_free_security+0x310/0x310 [ 989.813290] ? cap_capable+0x1ed/0x3f0 [ 989.818299] ? sysfs_file_ops+0x140/0x140 [ 989.823600] ? threaded_store+0x132/0x220 [ 989.828896] threaded_store+0x132/0x220 [ 989.834000] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.839495] ? sysfs_file_ops+0x140/0x140 [ 989.844790] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.850088] ? sysfs_kf_write+0x65/0x160 [ 989.855277] kernfs_fop_write_iter+0x335/0x510 [ 989.861066] ? kernfs_ops+0xf0/0xf0 [ 989.865782] new_sync_write+0x308/0x6f0 [ 989.870886] ? new_sync_read+0x6f0/0x6f0 [ 989.876091] ? lock_acquire.part.0+0xbc/0x260 [ 989.881780] ? ksys_write+0xff/0x200 [ 989.886593] vfs_write+0x62a/0x980 [ 989.891209] ksys_write+0xff/0x200 [ 989.895824] ? __ia32_sys_read+0xc0/0xc0 [ 989.901014] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.906603] ? rcu_is_watching+0x15/0xd0 [ 989.911796] do_syscall_64+0xf3/0x5e0 [ 989.916702] ? exc_page_fault+0x9e/0xb0 [ 989.921806] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.928277] RIP: 0033:0x7f001f06ac5e [ 989.933089] RSP: 002b:00007ffe03120960 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.942397] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f001f06ac5e [ 989.951208] RDX: 0000000000000001 RSI: 000055d7e1e92760 RDI: 0000000000000007 [ 989.960015] RBP: 00007ffe03120970 R08: 0000000000000000 R09: 0000000000000000 [ 989.968825] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f001ef05e80 [ 989.977635] R13: 000055d7e1e92760 R14: 0000000000000007 R15: 00007f001f76bb98 | [ 990.399397] #2: ff1100011fcf30f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.410555] #3: ff1100011fcd1d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.420642] | [ 990.423108] =============================================\x0a | [ 1014.290471] kworker/u130:3 (533) used greatest stack depth: 21192 bytes left [ 1112.596483] INFO: task python3:5440 blocked for more than 245 seconds. [ 1112.604633] Not tainted 7.0.0-rc6-qbvg-ga64f8f00fd9b #1 [ 1112.611883] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.621475] task:python3 state:D stack:25312 pid:5440 tgid:5440 ppid:5439 task_flags:0x400100 flags:0x00080000 [ 1112.634679] Call Trace: [ 1112.638218] [ 1112.641369] __schedule+0xad9/0x1490 [ 1112.646186] ? io_schedule_timeout+0x130/0x130 [ 1112.651974] ? find_held_lock+0x2b/0x80 [ 1112.657082] ? __lock_release.isra.0+0x59/0x170 [ 1112.662965] schedule+0xd4/0x260 [ 1112.667383] schedule_preempt_disabled+0x18/0x30 [ 1112.673365] __mutex_lock+0xd76/0x1f20 [ 1112.678373] ? threaded_store+0x132/0x220 [ 1112.683672] ? ww_mutex_lock+0x160/0x160 [ 1112.688871] ? selinux_inode_free_security+0x310/0x310 [ 1112.695442] ? cap_capable+0x1ed/0x3f0 [ 1112.700451] ? sysfs_file_ops+0x140/0x140 [ 1112.705753] ? threaded_store+0x132/0x220 [ 1112.711051] threaded_store+0x132/0x220 [ 1112.716147] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.721643] ? sysfs_file_ops+0x140/0x140 [ 1112.726939] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.732236] ? sysfs_kf_write+0x65/0x160 [ 1112.737439] kernfs_fop_write_iter+0x335/0x510 [ 1112.743223] ? kernfs_ops+0xf0/0xf0 [ 1112.747934] new_sync_write+0x308/0x6f0 [ 1112.753037] ? new_sync_read+0x6f0/0x6f0 [ 1112.758240] ? lock_acquire.part.0+0xbc/0x260 [ 1112.763927] ? ksys_write+0xff/0x200 [ 1112.768729] vfs_write+0x62a/0x980 [ 1112.773345] ksys_write+0xff/0x200 [ 1112.777952] ? __ia32_sys_read+0xc0/0xc0 [ 1112.783152] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.788735] ? rcu_is_watching+0x15/0xd0 [ 1112.793939] do_syscall_64+0xf3/0x5e0 [ 1112.798848] ? exc_page_fault+0x9e/0xb0 [ 1112.803949] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.810409] RIP: 0033:0x7f001f06ac5e [ 1112.815219] RSP: 002b:00007ffe03120960 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.824509] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f001f06ac5e [ 1112.833320] RDX: 0000000000000001 RSI: 000055d7e1e92760 RDI: 0000000000000007 [ 1112.842129] RBP: 00007ffe03120970 R08: 0000000000000000 R09: 0000000000000000 [ 1112.850935] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f001ef05e80 [ 1112.859745] R13: 000055d7e1e92760 R14: 0000000000000007 R15: 00007f001f76bb98 | [ 1113.230637] #1: ff110001dcbd5688 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.241599] #2: ff1100011fcf30f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.252751] #3: ff1100011fcd1d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.262847] | [ 1113.265317] =============================================\x0a [ 1235.476782] INFO: task python3:5440 blocked for more than 368 seconds. [ 1235.484930] Not tainted 7.0.0-rc6-qbvg-ga64f8f00fd9b #1 [ 1235.492179] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.501768] task:python3 state:D stack:25312 pid:5440 tgid:5440 ppid:5439 task_flags:0x400100 flags:0x00080002 [ 1235.514975] Call Trace: [ 1235.518515] [ 1235.521664] __schedule+0xad9/0x1490 [ 1235.526480] ? io_schedule_timeout+0x130/0x130 [ 1235.532264] ? find_held_lock+0x2b/0x80 [ 1235.537370] ? __lock_release.isra.0+0x59/0x170 [ 1235.543253] schedule+0xd4/0x260 [ 1235.547670] schedule_preempt_disabled+0x18/0x30 [ 1235.553649] __mutex_lock+0xd76/0x1f20 [ 1235.558655] ? threaded_store+0x132/0x220 [ 1235.563954] ? ww_mutex_lock+0x160/0x160 [ 1235.569151] ? selinux_inode_free_security+0x310/0x310 [ 1235.575718] ? cap_capable+0x1ed/0x3f0 [ 1235.580715] ? sysfs_file_ops+0x140/0x140 [ 1235.586017] ? threaded_store+0x132/0x220 [ 1235.591315] threaded_store+0x132/0x220 [ 1235.596416] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.601906] ? sysfs_file_ops+0x140/0x140 [ 1235.607204] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.612489] ? sysfs_kf_write+0x65/0x160 [ 1235.617689] kernfs_fop_write_iter+0x335/0x510 [ 1235.623475] ? kernfs_ops+0xf0/0xf0 [ 1235.628178] new_sync_write+0x308/0x6f0 [ 1235.633281] ? new_sync_read+0x6f0/0x6f0 [ 1235.638481] ? lock_acquire.part.0+0xbc/0x260 [ 1235.644157] ? ksys_write+0xff/0x200 [ 1235.648969] vfs_write+0x62a/0x980 [ 1235.653583] ksys_write+0xff/0x200 [ 1235.658195] ? __ia32_sys_read+0xc0/0xc0 [ 1235.663394] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.668977] ? rcu_is_watching+0x15/0xd0 [ 1235.674178] do_syscall_64+0xf3/0x5e0 [ 1235.679082] ? exc_page_fault+0x9e/0xb0 [ 1235.684184] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.690640] RIP: 0033:0x7f001f06ac5e [ 1235.695446] RSP: 002b:00007ffe03120960 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.704745] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f001f06ac5e [ 1235.713551] RDX: 0000000000000001 RSI: 000055d7e1e92760 RDI: 0000000000000007 [ 1235.722356] RBP: 00007ffe03120970 R08: 0000000000000000 R09: 0000000000000000 [ 1235.731160] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f001ef05e80 [ 1235.739966] R13: 000055d7e1e92760 R14: 0000000000000007 R15: 00007f001f76bb98 | [ 1236.150669] #1: ff110001dcbd5688 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.161626] #2: ff1100011fcf30f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.172782] #3: ff1100011fcd1d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.182872] | [ 1236.185336] =============================================\x0a [ 1358.359076] INFO: task python3:5440 blocked for more than 491 seconds. [ 1358.367225] Not tainted 7.0.0-rc6-qbvg-ga64f8f00fd9b #1 [ 1358.374474] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.384065] task:python3 state:D stack:25312 pid:5440 tgid:5440 ppid:5439 task_flags:0x400100 flags:0x00080002 [ 1358.397271] Call Trace: [ 1358.400808] [ 1358.403956] __schedule+0xad9/0x1490 [ 1358.408772] ? io_schedule_timeout+0x130/0x130 [ 1358.414558] ? find_held_lock+0x2b/0x80 [ 1358.419662] ? __lock_release.isra.0+0x59/0x170 [ 1358.425547] schedule+0xd4/0x260 [ 1358.429966] schedule_preempt_disabled+0x18/0x30 [ 1358.435945] __mutex_lock+0xd76/0x1f20 [ 1358.440949] ? threaded_store+0x132/0x220 [ 1358.446251] ? ww_mutex_lock+0x160/0x160 [ 1358.451449] ? selinux_inode_free_security+0x310/0x310 [ 1358.458018] ? cap_capable+0x1ed/0x3f0 [ 1358.463025] ? sysfs_file_ops+0x140/0x140 [ 1358.468324] ? threaded_store+0x132/0x220 [ 1358.473621] threaded_store+0x132/0x220 [ 1358.478725] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.484220] ? sysfs_file_ops+0x140/0x140 [ 1358.489516] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.494810] ? sysfs_kf_write+0x65/0x160 [ 1358.500009] kernfs_fop_write_iter+0x335/0x510 [ 1358.505793] ? kernfs_ops+0xf0/0xf0 [ 1358.510504] new_sync_write+0x308/0x6f0 [ 1358.515609] ? new_sync_read+0x6f0/0x6f0 [ 1358.520808] ? lock_acquire.part.0+0xbc/0x260 [ 1358.526493] ? ksys_write+0xff/0x200 [ 1358.531303] vfs_write+0x62a/0x980 [ 1358.535922] ksys_write+0xff/0x200 [ 1358.540536] ? __ia32_sys_read+0xc0/0xc0 [ 1358.545734] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.551323] ? rcu_is_watching+0x15/0xd0 [ 1358.556523] do_syscall_64+0xf3/0x5e0 [ 1358.561419] ? exc_page_fault+0x9e/0xb0 [ 1358.566518] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.572984] RIP: 0033:0x7f001f06ac5e [ 1358.577793] RSP: 002b:00007ffe03120960 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.587088] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f001f06ac5e [ 1358.595897] RDX: 0000000000000001 RSI: 000055d7e1e92760 RDI: 0000000000000007 [ 1358.604703] RBP: 00007ffe03120970 R08: 0000000000000000 R09: 0000000000000000 [ 1358.613507] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f001ef05e80 [ 1358.622317] R13: 000055d7e1e92760 R14: 0000000000000007 R15: 00007f001f76bb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store