====================================== | [ 761.904004] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 761.906438] nipa-hw-worker: [5/40] Retrying drivers/net:napi_threaded.py | [ 762.040427] kselftest: Running tests in drivers/net | [ 768.523349] kworker/u130:3 (533) used greatest stack depth: 21688 bytes left [ 989.706892] INFO: task python3:5265 blocked for more than 122 seconds. [ 989.715114] Not tainted 7.0.0-rc5-broq-g1c6f2b3c518a #1 [ 989.722362] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.731951] task:python3 state:D stack:25312 pid:5265 tgid:5265 ppid:5264 task_flags:0x400100 flags:0x00080000 [ 989.745149] Call Trace: [ 989.748687] [ 989.751835] __schedule+0xad9/0x1490 [ 989.756651] ? io_schedule_timeout+0x130/0x130 [ 989.762435] ? find_held_lock+0x2b/0x80 [ 989.767540] ? __lock_release.isra.0+0x59/0x170 [ 989.773415] schedule+0xd4/0x260 [ 989.777834] schedule_preempt_disabled+0x18/0x30 [ 989.783814] __mutex_lock+0xd76/0x1f20 [ 989.788812] ? threaded_store+0x132/0x220 [ 989.794109] ? ww_mutex_lock+0x160/0x160 [ 989.799306] ? selinux_inode_free_security+0x310/0x310 [ 989.805875] ? cap_capable+0x1ed/0x3f0 [ 989.810881] ? sysfs_file_ops+0x140/0x140 [ 989.816179] ? threaded_store+0x132/0x220 [ 989.821472] threaded_store+0x132/0x220 [ 989.826576] ? tx_maxrate_store+0x4e0/0x4e0 [ 989.832067] ? sysfs_file_ops+0x140/0x140 [ 989.837364] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.842657] ? sysfs_kf_write+0x65/0x160 [ 989.847857] kernfs_fop_write_iter+0x335/0x510 [ 989.853633] ? kernfs_ops+0xf0/0xf0 [ 989.858345] new_sync_write+0x308/0x6f0 [ 989.863438] ? new_sync_read+0x6f0/0x6f0 [ 989.868639] ? lock_acquire.part.0+0xbc/0x260 [ 989.874324] ? ksys_write+0xff/0x200 [ 989.879134] vfs_write+0x62a/0x980 [ 989.883739] ksys_write+0xff/0x200 [ 989.888351] ? __ia32_sys_read+0xc0/0xc0 [ 989.893546] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.899133] ? rcu_is_watching+0x15/0xd0 [ 989.904334] do_syscall_64+0xf3/0x5e0 [ 989.909239] ? irq_exit_rcu+0x39/0xf0 [ 989.914147] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.920616] RIP: 0033:0x7fe6024ddc5e [ 989.925425] RSP: 002b:00007ffcae88efb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.934728] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fe6024ddc5e [ 989.943533] RDX: 0000000000000001 RSI: 000056325d0ce760 RDI: 0000000000000007 [ 989.952342] RBP: 00007ffcae88efc0 R08: 0000000000000000 R09: 0000000000000000 [ 989.961150] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fe602378e80 [ 989.969956] R13: 000056325d0ce760 R14: 0000000000000007 R15: 00007fe602bdeb98 | [ 990.340577] #1: ff11000187d4e288 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 990.351538] #2: ff110001210bf0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.362686] #3: ff11000121129d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.372777] | [ 990.375240] =============================================\x0a [ 1112.589146] INFO: task python3:5265 blocked for more than 245 seconds. [ 1112.597294] Not tainted 7.0.0-rc5-broq-g1c6f2b3c518a #1 [ 1112.604544] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.614137] task:python3 state:D stack:25312 pid:5265 tgid:5265 ppid:5264 task_flags:0x400100 flags:0x00080000 [ 1112.627346] Call Trace: [ 1112.630887] [ 1112.634035] __schedule+0xad9/0x1490 [ 1112.638855] ? io_schedule_timeout+0x130/0x130 [ 1112.644642] ? find_held_lock+0x2b/0x80 [ 1112.649749] ? __lock_release.isra.0+0x59/0x170 [ 1112.655635] schedule+0xd4/0x260 [ 1112.660053] schedule_preempt_disabled+0x18/0x30 [ 1112.666031] __mutex_lock+0xd76/0x1f20 [ 1112.671037] ? threaded_store+0x132/0x220 [ 1112.676336] ? ww_mutex_lock+0x160/0x160 [ 1112.681536] ? selinux_inode_free_security+0x310/0x310 [ 1112.688106] ? cap_capable+0x1ed/0x3f0 [ 1112.693115] ? sysfs_file_ops+0x140/0x140 [ 1112.698418] ? threaded_store+0x132/0x220 [ 1112.703713] threaded_store+0x132/0x220 [ 1112.708814] ? tx_maxrate_store+0x4e0/0x4e0 [ 1112.714306] ? sysfs_file_ops+0x140/0x140 [ 1112.719602] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.724898] ? sysfs_kf_write+0x65/0x160 [ 1112.730101] kernfs_fop_write_iter+0x335/0x510 [ 1112.735888] ? kernfs_ops+0xf0/0xf0 [ 1112.740600] new_sync_write+0x308/0x6f0 [ 1112.745704] ? new_sync_read+0x6f0/0x6f0 [ 1112.750905] ? lock_acquire.part.0+0xbc/0x260 [ 1112.756591] ? ksys_write+0xff/0x200 [ 1112.761402] vfs_write+0x62a/0x980 [ 1112.766018] ksys_write+0xff/0x200 [ 1112.770632] ? __ia32_sys_read+0xc0/0xc0 [ 1112.775829] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.781420] ? rcu_is_watching+0x15/0xd0 [ 1112.786622] do_syscall_64+0xf3/0x5e0 [ 1112.791527] ? irq_exit_rcu+0x39/0xf0 [ 1112.796437] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.802906] RIP: 0033:0x7fe6024ddc5e [ 1112.807716] RSP: 002b:00007ffcae88efb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.817012] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fe6024ddc5e [ 1112.825824] RDX: 0000000000000001 RSI: 000056325d0ce760 RDI: 0000000000000007 [ 1112.834632] RBP: 00007ffcae88efc0 R08: 0000000000000000 R09: 0000000000000000 [ 1112.843432] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fe602378e80 [ 1112.852243] R13: 000056325d0ce760 R14: 0000000000000007 R15: 00007fe602bdeb98 | [ 1113.228951] #1: ff11000187d4e288 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1113.239915] #2: ff110001210bf0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.251073] #3: ff11000121129d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.261166] | [ 1113.263634] =============================================\x0a [ 1235.470437] INFO: task python3:5265 blocked for more than 368 seconds. [ 1235.478587] Not tainted 7.0.0-rc5-broq-g1c6f2b3c518a #1 [ 1235.485837] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.495425] task:python3 state:D stack:25312 pid:5265 tgid:5265 ppid:5264 task_flags:0x400100 flags:0x00080002 [ 1235.508632] Call Trace: [ 1235.512172] [ 1235.515324] __schedule+0xad9/0x1490 [ 1235.520137] ? io_schedule_timeout+0x130/0x130 [ 1235.525921] ? find_held_lock+0x2b/0x80 [ 1235.531028] ? __lock_release.isra.0+0x59/0x170 [ 1235.536912] schedule+0xd4/0x260 [ 1235.541328] schedule_preempt_disabled+0x18/0x30 [ 1235.547305] __mutex_lock+0xd76/0x1f20 [ 1235.552308] ? threaded_store+0x132/0x220 [ 1235.557607] ? ww_mutex_lock+0x160/0x160 [ 1235.562805] ? selinux_inode_free_security+0x310/0x310 [ 1235.569364] ? cap_capable+0x1ed/0x3f0 [ 1235.574371] ? sysfs_file_ops+0x140/0x140 [ 1235.579667] ? threaded_store+0x132/0x220 [ 1235.584962] threaded_store+0x132/0x220 [ 1235.590067] ? tx_maxrate_store+0x4e0/0x4e0 [ 1235.595558] ? sysfs_file_ops+0x140/0x140 [ 1235.600856] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.606151] ? sysfs_kf_write+0x65/0x160 [ 1235.611350] kernfs_fop_write_iter+0x335/0x510 [ 1235.617133] ? kernfs_ops+0xf0/0xf0 [ 1235.621845] new_sync_write+0x308/0x6f0 [ 1235.626938] ? new_sync_read+0x6f0/0x6f0 [ 1235.632138] ? lock_acquire.part.0+0xbc/0x260 [ 1235.637825] ? ksys_write+0xff/0x200 [ 1235.642636] vfs_write+0x62a/0x980 [ 1235.647251] ksys_write+0xff/0x200 [ 1235.651864] ? __ia32_sys_read+0xc0/0xc0 [ 1235.657061] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.662648] ? rcu_is_watching+0x15/0xd0 [ 1235.667849] do_syscall_64+0xf3/0x5e0 [ 1235.672754] ? irq_exit_rcu+0x39/0xf0 [ 1235.677663] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.684123] RIP: 0033:0x7fe6024ddc5e [ 1235.688933] RSP: 002b:00007ffcae88efb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.698232] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fe6024ddc5e [ 1235.707037] RDX: 0000000000000001 RSI: 000056325d0ce760 RDI: 0000000000000007 [ 1235.715845] RBP: 00007ffcae88efc0 R08: 0000000000000000 R09: 0000000000000000 [ 1235.724642] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fe602378e80 [ 1235.733450] R13: 000056325d0ce760 R14: 0000000000000007 R15: 00007fe602bdeb98 | [ 1236.104062] #1: ff11000187d4e288 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x247/0x510 | [ 1236.115020] #2: ff110001210bf0f0 (kn->active#127){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.126178] #3: ff11000121129d00 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.136277] | [ 1236.138741] =============================================\x0a [ 1358.351723] INFO: task python3:5265 blocked for more than 491 seconds. [ 1358.360481] Not tainted 7.0.0-rc5-broq-g1c6f2b3c518a #1 [ 1358.367742] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.377333] task:python3 state:D stack:25312 pid:5265 tgid:5265 ppid:5264 task_flags:0x400100 flags:0x00080002 [ 1358.390537] Call Trace: [ 1358.394077] [ 1358.397230] __schedule+0xad9/0x1490 [ 1358.402045] ? io_schedule_timeout+0x130/0x130 [ 1358.407828] ? find_held_lock+0x2b/0x80 [ 1358.412927] ? __lock_release.isra.0+0x59/0x170 [ 1358.418809] schedule+0xd4/0x260 [ 1358.423225] schedule_preempt_disabled+0x18/0x30 [ 1358.429204] __mutex_lock+0xd76/0x1f20 [ 1358.434210] ? threaded_store+0x132/0x220 [ 1358.439511] ? ww_mutex_lock+0x160/0x160 [ 1358.444708] ? selinux_inode_free_security+0x310/0x310 [ 1358.451279] ? cap_capable+0x1ed/0x3f0 [ 1358.456287] ? sysfs_file_ops+0x140/0x140 [ 1358.461585] ? threaded_store+0x132/0x220 [ 1358.466882] threaded_store+0x132/0x220 [ 1358.471987] ? tx_maxrate_store+0x4e0/0x4e0 [ 1358.477478] ? sysfs_file_ops+0x140/0x140 [ 1358.482773] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.488070] ? sysfs_kf_write+0x65/0x160 [ 1358.493268] kernfs_fop_write_iter+0x335/0x510 [ 1358.499052] ? kernfs_ops+0xf0/0xf0 [ 1358.503762] new_sync_write+0x308/0x6f0 [ 1358.508865] ? new_sync_read+0x6f0/0x6f0 [ 1358.514056] ? lock_acquire.part.0+0xbc/0x260 [ 1358.519743] ? ksys_write+0xff/0x200 [ 1358.524557] vfs_write+0x62a/0x980 [ 1358.529170] ksys_write+0xff/0x200 [ 1358.533782] ? __ia32_sys_read+0xc0/0xc0 [ 1358.538980] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.544570] ? rcu_is_watching+0x15/0xd0 [ 1358.549768] do_syscall_64+0xf3/0x5e0 [ 1358.554675] ? irq_exit_rcu+0x39/0xf0 [ 1358.559582] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.566049] RIP: 0033:0x7fe6024ddc5e [ 1358.570850] RSP: 002b:00007ffcae88efb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.580138] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fe6024ddc5e [ 1358.588940] RDX: 0000000000000001 RSI: 000056325d0ce760 RDI: 0000000000000007 [ 1358.597747] RBP: 00007ffcae88efc0 R08: 0000000000000000 R09: 0000000000000000 [ 1358.606558] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fe602378e80 [ 1358.615367] R13: 000056325d0ce760 R14: 0000000000000007 R15: 00007fe602bdeb98 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store