====================================== | [ 740.451440] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 740.454083] nipa-hw-worker: [4/36] Retrying drivers/net:napi_threaded.py | [ 740.592778] kselftest: Running tests in drivers/net [ 866.864409] INFO: task python3:4670 blocked for more than 122 seconds. [ 866.872641] Not tainted 7.0.0-rc3-yxic-g32dca9ae1adf #1 [ 866.879893] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 866.889484] task:python3 state:D stack:25312 pid:4670 tgid:4670 ppid:4668 task_flags:0x400100 flags:0x00080000 [ 866.902689] Call Trace: [ 866.906229] [ 866.909382] __schedule+0xad9/0x1490 [ 866.914199] ? io_schedule_timeout+0x130/0x130 [ 866.919982] ? find_held_lock+0x2b/0x80 [ 866.925089] ? __lock_release.isra.0+0x59/0x170 [ 866.930974] schedule+0xd4/0x260 [ 866.935384] schedule_preempt_disabled+0x18/0x30 [ 866.941364] __mutex_lock+0xd76/0x1f20 [ 866.946361] ? threaded_store+0x132/0x220 [ 866.951661] ? ww_mutex_lock+0x160/0x160 [ 866.956861] ? selinux_inode_free_security+0x310/0x310 [ 866.963434] ? cap_capable+0x1ed/0x3f0 [ 866.968441] ? sysfs_file_ops+0x140/0x140 [ 866.973738] ? threaded_store+0x132/0x220 [ 866.979037] threaded_store+0x132/0x220 [ 866.984137] ? tx_maxrate_store+0x4e0/0x4e0 [ 866.989634] ? sysfs_file_ops+0x140/0x140 [ 866.994930] ? sysfs_file_kobj+0xbd/0x1e0 [ 867.000229] ? sysfs_kf_write+0x65/0x160 [ 867.005430] kernfs_fop_write_iter+0x335/0x510 [ 867.011215] ? kernfs_ops+0xf0/0xf0 [ 867.015920] new_sync_write+0x308/0x6f0 [ 867.021026] ? new_sync_read+0x6f0/0x6f0 [ 867.026225] ? lock_acquire.part.0+0xbc/0x260 [ 867.031911] ? ksys_write+0xff/0x200 [ 867.036726] vfs_write+0x62a/0x980 [ 867.041340] ksys_write+0xff/0x200 [ 867.045952] ? __ia32_sys_read+0xc0/0xc0 [ 867.051152] ? kernfs_fop_llseek+0x160/0x1f0 [ 867.056743] ? rcu_is_watching+0x15/0xd0 [ 867.061946] do_syscall_64+0xf3/0x5e0 [ 867.066854] ? irq_exit_rcu+0x39/0xf0 [ 867.071760] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 867.078229] RIP: 0033:0x7f308419bc5e [ 867.083039] RSP: 002b:00007ffd303a8ec0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 867.092339] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f308419bc5e [ 867.101148] RDX: 0000000000000001 RSI: 0000555701e96cd0 RDI: 0000000000000007 [ 867.109955] RBP: 00007ffd303a8ed0 R08: 0000000000000000 R09: 0000000000000000 [ 867.118762] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3084036e80 [ 867.127569] R13: 0000555701e96cd0 R14: 0000000000000007 R15: 00007f308489cb98 | [ 867.538152] #1: ff1100015dbd1a88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 867.549114] #2: ff110001116530f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 867.560269] #3: ff110001116b9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 867.570354] | [ 867.572822] =============================================\x0a [ 989.744642] INFO: task python3:4670 blocked for more than 245 seconds. [ 989.752788] Not tainted 7.0.0-rc3-yxic-g32dca9ae1adf #1 [ 989.760038] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.769627] task:python3 state:D stack:25312 pid:4670 tgid:4670 ppid:4668 task_flags:0x400100 flags:0x00080002 [ 989.782824] Call Trace: [ 989.786364] [ 989.789513] __schedule+0xad9/0x1490 [ 989.794328] ? io_schedule_timeout+0x130/0x130 [ 989.800115] ? find_held_lock+0x2b/0x80 [ 989.805221] ? __lock_release.isra.0+0x59/0x170 [ 989.811106] schedule+0xd4/0x260 [ 989.815524] schedule_preempt_disabled+0x18/0x30 [ 989.821501] __mutex_lock+0xd76/0x1f20 [ 989.826506] ? threaded_store+0x132/0x220 [ 989.831806] ? ww_mutex_lock+0x160/0x160 [ 989.837007] ? selinux_inode_free_security+0x310/0x310 [ 989.843576] ? cap_capable+0x1ed/0x3f0 [ 989.848582] ? sysfs_file_ops+0x140/0x140 [ 989.853883] ? threaded_store+0x132/0x220 [ 989.859179] threaded_store+0x132/0x220 [ 989.864282] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.869776] ? sysfs_file_ops+0x140/0x140 [ 989.875077] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.880375] ? sysfs_kf_write+0x65/0x160 [ 989.885577] kernfs_fop_write_iter+0x335/0x510 [ 989.891364] ? kernfs_ops+0xf0/0xf0 [ 989.896077] new_sync_write+0x308/0x6f0 [ 989.901181] ? new_sync_read+0x6f0/0x6f0 [ 989.906382] ? lock_acquire.part.0+0xbc/0x260 [ 989.912070] ? ksys_write+0xff/0x200 [ 989.916873] vfs_write+0x62a/0x980 [ 989.921488] ksys_write+0xff/0x200 [ 989.926094] ? __ia32_sys_read+0xc0/0xc0 [ 989.931292] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.936883] ? rcu_is_watching+0x15/0xd0 [ 989.942085] do_syscall_64+0xf3/0x5e0 [ 989.946990] ? irq_exit_rcu+0x39/0xf0 [ 989.951899] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.958366] RIP: 0033:0x7f308419bc5e [ 989.963168] RSP: 002b:00007ffd303a8ec0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.972470] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f308419bc5e [ 989.981278] RDX: 0000000000000001 RSI: 0000555701e96cd0 RDI: 0000000000000007 [ 989.990087] RBP: 00007ffd303a8ed0 R08: 0000000000000000 R09: 0000000000000000 [ 989.998896] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3084036e80 [ 990.007703] R13: 0000555701e96cd0 R14: 0000000000000007 R15: 00007f308489cb98 | [ 990.378214] #1: ff1100015dbd1a88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.389186] #2: ff110001116530f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.400342] #3: ff110001116b9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.410434] | [ 990.412900] =============================================\x0a [ 1112.625811] INFO: task python3:4670 blocked for more than 368 seconds. [ 1112.633959] Not tainted 7.0.0-rc3-yxic-g32dca9ae1adf #1 [ 1112.641209] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.650800] task:python3 state:D stack:25312 pid:4670 tgid:4670 ppid:4668 task_flags:0x400100 flags:0x00080002 [ 1112.664003] Call Trace: [ 1112.667541] [ 1112.670690] __schedule+0xad9/0x1490 [ 1112.675502] ? io_schedule_timeout+0x130/0x130 [ 1112.681288] ? find_held_lock+0x2b/0x80 [ 1112.686392] ? __lock_release.isra.0+0x59/0x170 [ 1112.692276] schedule+0xd4/0x260 [ 1112.696692] schedule_preempt_disabled+0x18/0x30 [ 1112.702669] __mutex_lock+0xd76/0x1f20 [ 1112.707672] ? threaded_store+0x132/0x220 [ 1112.712962] ? ww_mutex_lock+0x160/0x160 [ 1112.718160] ? selinux_inode_free_security+0x310/0x310 [ 1112.724730] ? cap_capable+0x1ed/0x3f0 [ 1112.729737] ? sysfs_file_ops+0x140/0x140 [ 1112.735037] ? threaded_store+0x132/0x220 [ 1112.740323] threaded_store+0x132/0x220 [ 1112.745427] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.750920] ? sysfs_file_ops+0x140/0x140 [ 1112.756214] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.761509] ? sysfs_kf_write+0x65/0x160 [ 1112.766710] kernfs_fop_write_iter+0x335/0x510 [ 1112.772496] ? kernfs_ops+0xf0/0xf0 [ 1112.777204] new_sync_write+0x308/0x6f0 [ 1112.782307] ? new_sync_read+0x6f0/0x6f0 [ 1112.787509] ? lock_acquire.part.0+0xbc/0x260 [ 1112.793196] ? ksys_write+0xff/0x200 [ 1112.798007] vfs_write+0x62a/0x980 [ 1112.802622] ksys_write+0xff/0x200 [ 1112.807235] ? __ia32_sys_read+0xc0/0xc0 [ 1112.812432] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.818021] ? rcu_is_watching+0x15/0xd0 [ 1112.823221] do_syscall_64+0xf3/0x5e0 [ 1112.828126] ? irq_exit_rcu+0x39/0xf0 [ 1112.833034] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.839500] RIP: 0033:0x7f308419bc5e [ 1112.844310] RSP: 002b:00007ffd303a8ec0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.853608] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f308419bc5e [ 1112.862417] RDX: 0000000000000001 RSI: 0000555701e96cd0 RDI: 0000000000000007 [ 1112.871225] RBP: 00007ffd303a8ed0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.880030] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3084036e80 [ 1112.888836] R13: 0000555701e96cd0 R14: 0000000000000007 R15: 00007f308489cb98 | [ 1113.259255] #1: ff1100015dbd1a88 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.270218] #2: ff110001116530f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.281375] #3: ff110001116b9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.291454] | [ 1113.293924] =============================================\x0a [ 1235.508008] INFO: task python3:4670 blocked for more than 491 seconds. [ 1235.516154] Not tainted 7.0.0-rc3-yxic-g32dca9ae1adf #1 [ 1235.523404] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.532994] task:python3 state:D stack:25312 pid:4670 tgid:4670 ppid:4668 task_flags:0x400100 flags:0x00080002 [ 1235.546201] Call Trace: [ 1235.549740] [ 1235.552892] __schedule+0xad9/0x1490 [ 1235.557707] ? io_schedule_timeout+0x130/0x130 [ 1235.563490] ? find_held_lock+0x2b/0x80 [ 1235.568587] ? __lock_release.isra.0+0x59/0x170 [ 1235.574472] schedule+0xd4/0x260 [ 1235.578888] schedule_preempt_disabled+0x18/0x30 [ 1235.584868] __mutex_lock+0xd76/0x1f20 [ 1235.589871] ? threaded_store+0x132/0x220 [ 1235.595168] ? ww_mutex_lock+0x160/0x160 [ 1235.600367] ? selinux_inode_free_security+0x310/0x310 [ 1235.606936] ? cap_capable+0x1ed/0x3f0 [ 1235.611944] ? sysfs_file_ops+0x140/0x140 [ 1235.617238] ? threaded_store+0x132/0x220 [ 1235.622533] threaded_store+0x132/0x220 [ 1235.627634] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.633126] ? sysfs_file_ops+0x140/0x140 [ 1235.638420] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.643715] ? sysfs_kf_write+0x65/0x160 [ 1235.648916] kernfs_fop_write_iter+0x335/0x510 [ 1235.654702] ? kernfs_ops+0xf0/0xf0 [ 1235.659411] new_sync_write+0x308/0x6f0 [ 1235.664512] ? new_sync_read+0x6f0/0x6f0 [ 1235.669713] ? lock_acquire.part.0+0xbc/0x260 [ 1235.675396] ? ksys_write+0xff/0x200 [ 1235.680206] vfs_write+0x62a/0x980 [ 1235.684820] ksys_write+0xff/0x200 [ 1235.689434] ? __ia32_sys_read+0xc0/0xc0 [ 1235.694629] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.700216] ? rcu_is_watching+0x15/0xd0 [ 1235.705418] do_syscall_64+0xf3/0x5e0 [ 1235.710322] ? irq_exit_rcu+0x39/0xf0 [ 1235.715230] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.721695] RIP: 0033:0x7f308419bc5e [ 1235.726505] RSP: 002b:00007ffd303a8ec0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.735802] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f308419bc5e [ 1235.744608] RDX: 0000000000000001 RSI: 0000555701e96cd0 RDI: 0000000000000007 [ 1235.753413] RBP: 00007ffd303a8ed0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.762222] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f3084036e80 [ 1235.771028] R13: 0000555701e96cd0 R14: 0000000000000007 R15: 00007f308489cb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store