====================================== | [ 740.352274] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 740.356365] nipa-hw-worker: [4/36] Retrying drivers/net:napi_threaded.py | [ 740.520051] kselftest: Running tests in drivers/net | [ 862.749129] kworker/u130:4 (529) used greatest stack depth: 21896 bytes left [ 866.844157] INFO: task python3:4687 blocked for more than 122 seconds. [ 866.852389] Not tainted 7.0.0-rc3-crws-gdc41423dc228 #1 [ 866.859636] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 866.869223] task:python3 state:D stack:25312 pid:4687 tgid:4687 ppid:4686 task_flags:0x400100 flags:0x00080000 [ 866.882427] Call Trace: [ 866.885963] [ 866.889114] __schedule+0xad9/0x1490 [ 866.893926] ? io_schedule_timeout+0x130/0x130 [ 866.899704] ? find_held_lock+0x2b/0x80 [ 866.904807] ? __lock_release.isra.0+0x59/0x170 [ 866.910694] schedule+0xd4/0x260 [ 866.915111] schedule_preempt_disabled+0x18/0x30 [ 866.921089] __mutex_lock+0xd76/0x1f20 [ 866.926094] ? threaded_store+0x132/0x220 [ 866.931393] ? ww_mutex_lock+0x160/0x160 [ 866.936593] ? selinux_inode_free_security+0x310/0x310 [ 866.943163] ? cap_capable+0x1ed/0x3f0 [ 866.948171] ? sysfs_file_ops+0x140/0x140 [ 866.953473] ? threaded_store+0x132/0x220 [ 866.958767] threaded_store+0x132/0x220 [ 866.963869] ? tx_maxrate_store+0x4e0/0x4e0 [ 866.969360] ? sysfs_file_ops+0x140/0x140 [ 866.974655] ? sysfs_file_kobj+0xbd/0x1e0 [ 866.979951] ? sysfs_kf_write+0x65/0x160 [ 866.985149] kernfs_fop_write_iter+0x335/0x510 [ 866.990931] ? kernfs_ops+0xf0/0xf0 [ 866.995643] new_sync_write+0x308/0x6f0 [ 867.000745] ? new_sync_read+0x6f0/0x6f0 [ 867.005946] ? lock_acquire.part.0+0xbc/0x260 [ 867.011633] ? ksys_write+0xff/0x200 [ 867.016445] vfs_write+0x62a/0x980 [ 867.021059] ksys_write+0xff/0x200 [ 867.025672] ? __ia32_sys_read+0xc0/0xc0 [ 867.030869] ? kernfs_fop_llseek+0x160/0x1f0 [ 867.036457] ? rcu_is_watching+0x15/0xd0 [ 867.041660] do_syscall_64+0xf3/0x5e0 [ 867.046563] ? exc_page_fault+0x9e/0xb0 [ 867.051662] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 867.058128] RIP: 0033:0x7fdb7c1dac5e [ 867.062936] RSP: 002b:00007ffc2409e890 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 867.072232] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fdb7c1dac5e [ 867.081039] RDX: 0000000000000001 RSI: 000055774b178cd0 RDI: 0000000000000007 [ 867.089846] RBP: 00007ffc2409e8a0 R08: 0000000000000000 R09: 0000000000000000 [ 867.098644] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fdb7c075e80 [ 867.107451] R13: 000055774b178cd0 R14: 0000000000000007 R15: 00007fdb7c8dbb98 | [ 867.478044] #1: ff11000158f30888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 867.489005] #2: ff110001223090f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 867.500155] #3: ff110001222e9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 867.510244] | [ 867.512708] =============================================\x0a [ 989.726381] INFO: task python3:4687 blocked for more than 245 seconds. [ 989.734532] Not tainted 7.0.0-rc3-crws-gdc41423dc228 #1 [ 989.741786] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.751377] task:python3 state:D stack:25312 pid:4687 tgid:4687 ppid:4686 task_flags:0x400100 flags:0x00080002 [ 989.764583] Call Trace: [ 989.768122] [ 989.771272] __schedule+0xad9/0x1490 [ 989.776087] ? io_schedule_timeout+0x130/0x130 [ 989.781872] ? find_held_lock+0x2b/0x80 [ 989.786979] ? __lock_release.isra.0+0x59/0x170 [ 989.792870] schedule+0xd4/0x260 [ 989.797291] schedule_preempt_disabled+0x18/0x30 [ 989.803272] __mutex_lock+0xd76/0x1f20 [ 989.808280] ? threaded_store+0x132/0x220 [ 989.813580] ? ww_mutex_lock+0x160/0x160 [ 989.818778] ? selinux_inode_free_security+0x310/0x310 [ 989.825351] ? cap_capable+0x1ed/0x3f0 [ 989.830359] ? sysfs_file_ops+0x140/0x140 [ 989.835660] ? threaded_store+0x132/0x220 [ 989.840956] threaded_store+0x132/0x220 [ 989.846058] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.851549] ? sysfs_file_ops+0x140/0x140 [ 989.856845] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.862144] ? sysfs_kf_write+0x65/0x160 [ 989.867342] kernfs_fop_write_iter+0x335/0x510 [ 989.873126] ? kernfs_ops+0xf0/0xf0 [ 989.877838] new_sync_write+0x308/0x6f0 [ 989.882943] ? new_sync_read+0x6f0/0x6f0 [ 989.888141] ? lock_acquire.part.0+0xbc/0x260 [ 989.893831] ? ksys_write+0xff/0x200 [ 989.898642] vfs_write+0x62a/0x980 [ 989.903256] ksys_write+0xff/0x200 [ 989.907871] ? __ia32_sys_read+0xc0/0xc0 [ 989.913070] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.918658] ? rcu_is_watching+0x15/0xd0 [ 989.923863] do_syscall_64+0xf3/0x5e0 [ 989.928770] ? exc_page_fault+0x9e/0xb0 [ 989.933865] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.940333] RIP: 0033:0x7fdb7c1dac5e [ 989.945144] RSP: 002b:00007ffc2409e890 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.954444] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fdb7c1dac5e [ 989.963254] RDX: 0000000000000001 RSI: 000055774b178cd0 RDI: 0000000000000007 [ 989.972062] RBP: 00007ffc2409e8a0 R08: 0000000000000000 R09: 0000000000000000 [ 989.980861] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fdb7c075e80 [ 989.989671] R13: 000055774b178cd0 R14: 0000000000000007 R15: 00007fdb7c8dbb98 | [ 990.426229] #1: ff11000158f30888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.437190] #2: ff110001223090f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.448345] #3: ff110001222e9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.458436] | [ 990.460902] =============================================\x0a [ 1112.606588] INFO: task python3:4687 blocked for more than 368 seconds. [ 1112.614738] Not tainted 7.0.0-rc3-crws-gdc41423dc228 #1 [ 1112.621988] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.631580] task:python3 state:D stack:25312 pid:4687 tgid:4687 ppid:4686 task_flags:0x400100 flags:0x00080002 [ 1112.644788] Call Trace: [ 1112.648329] [ 1112.651479] __schedule+0xad9/0x1490 [ 1112.656295] ? io_schedule_timeout+0x130/0x130 [ 1112.662082] ? find_held_lock+0x2b/0x80 [ 1112.667187] ? __lock_release.isra.0+0x59/0x170 [ 1112.673071] schedule+0xd4/0x260 [ 1112.677481] schedule_preempt_disabled+0x18/0x30 [ 1112.683461] __mutex_lock+0xd76/0x1f20 [ 1112.688470] ? threaded_store+0x132/0x220 [ 1112.693771] ? ww_mutex_lock+0x160/0x160 [ 1112.698968] ? selinux_inode_free_security+0x310/0x310 [ 1112.705536] ? cap_capable+0x1ed/0x3f0 [ 1112.710544] ? sysfs_file_ops+0x140/0x140 [ 1112.715845] ? threaded_store+0x132/0x220 [ 1112.721145] threaded_store+0x132/0x220 [ 1112.726325] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.731811] ? sysfs_file_ops+0x140/0x140 [ 1112.737109] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.742406] ? sysfs_kf_write+0x65/0x160 [ 1112.747675] kernfs_fop_write_iter+0x335/0x510 [ 1112.753454] ? kernfs_ops+0xf0/0xf0 [ 1112.758166] new_sync_write+0x308/0x6f0 [ 1112.763268] ? new_sync_read+0x6f0/0x6f0 [ 1112.768470] ? lock_acquire.part.0+0xbc/0x260 [ 1112.774226] ? ksys_write+0xff/0x200 [ 1112.779042] vfs_write+0x62a/0x980 [ 1112.783659] ksys_write+0xff/0x200 [ 1112.788275] ? __ia32_sys_read+0xc0/0xc0 [ 1112.793474] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.799057] ? rcu_is_watching+0x15/0xd0 [ 1112.804261] do_syscall_64+0xf3/0x5e0 [ 1112.809169] ? exc_page_fault+0x9e/0xb0 [ 1112.814274] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.820744] RIP: 0033:0x7fdb7c1dac5e [ 1112.825554] RSP: 002b:00007ffc2409e890 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.834852] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fdb7c1dac5e [ 1112.843662] RDX: 0000000000000001 RSI: 000055774b178cd0 RDI: 0000000000000007 [ 1112.852470] RBP: 00007ffc2409e8a0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.861280] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fdb7c075e80 [ 1112.870089] R13: 000055774b178cd0 R14: 0000000000000007 R15: 00007fdb7c8dbb98 | [ 1113.280994] #1: ff11000158f30888 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.291957] #2: ff110001223090f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.303115] #3: ff110001222e9cb8 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.313205] | [ 1113.315671] =============================================\x0a [ 1235.488830] INFO: task python3:4687 blocked for more than 491 seconds. [ 1235.496979] Not tainted 7.0.0-rc3-crws-gdc41423dc228 #1 [ 1235.504229] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.513821] task:python3 state:D stack:25312 pid:4687 tgid:4687 ppid:4686 task_flags:0x400100 flags:0x00080002 [ 1235.527029] Call Trace: [ 1235.530569] [ 1235.533723] __schedule+0xad9/0x1490 [ 1235.538541] ? io_schedule_timeout+0x130/0x130 [ 1235.544329] ? find_held_lock+0x2b/0x80 [ 1235.549436] ? __lock_release.isra.0+0x59/0x170 [ 1235.555322] schedule+0xd4/0x260 [ 1235.559739] schedule_preempt_disabled+0x18/0x30 [ 1235.565720] __mutex_lock+0xd76/0x1f20 [ 1235.570724] ? threaded_store+0x132/0x220 [ 1235.576021] ? ww_mutex_lock+0x160/0x160 [ 1235.581221] ? selinux_inode_free_security+0x310/0x310 [ 1235.587790] ? cap_capable+0x1ed/0x3f0 [ 1235.592799] ? sysfs_file_ops+0x140/0x140 [ 1235.598100] ? threaded_store+0x132/0x220 [ 1235.603396] threaded_store+0x132/0x220 [ 1235.608498] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.613991] ? sysfs_file_ops+0x140/0x140 [ 1235.619291] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.624587] ? sysfs_kf_write+0x65/0x160 [ 1235.629788] kernfs_fop_write_iter+0x335/0x510 [ 1235.635574] ? kernfs_ops+0xf0/0xf0 [ 1235.640286] new_sync_write+0x308/0x6f0 [ 1235.645388] ? new_sync_read+0x6f0/0x6f0 [ 1235.650589] ? lock_acquire.part.0+0xbc/0x260 [ 1235.656277] ? ksys_write+0xff/0x200 [ 1235.661088] vfs_write+0x62a/0x980 [ 1235.665704] ksys_write+0xff/0x200 [ 1235.670318] ? __ia32_sys_read+0xc0/0xc0 [ 1235.675515] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.681105] ? rcu_is_watching+0x15/0xd0 [ 1235.686307] do_syscall_64+0xf3/0x5e0 [ 1235.691216] ? exc_page_fault+0x9e/0xb0 [ 1235.696319] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.702788] RIP: 0033:0x7fdb7c1dac5e [ 1235.707600] RSP: 002b:00007ffc2409e890 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.716896] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fdb7c1dac5e [ 1235.725706] RDX: 0000000000000001 RSI: 000055774b178cd0 RDI: 0000000000000007 [ 1235.734514] RBP: 00007ffc2409e8a0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.743313] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fdb7c075e80 [ 1235.752113] R13: 000055774b178cd0 R14: 0000000000000007 R15: 00007fdb7c8dbb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store