====================================== | [ 764.687931] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 764.690687] nipa-hw-worker: [5/47] Retrying drivers/net:napi_threaded.py | [ 764.819411] kselftest: Running tests in drivers/net [ 989.717623] INFO: task python3:5413 blocked for more than 122 seconds. [ 989.725819] Not tainted 7.1.0-rc6-ohzb-g91a26bc64654 #1 [ 989.733498] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.743085] task:python3 state:D stack:25672 pid:5413 tgid:5413 ppid:5411 task_flags:0x400100 flags:0x00080000 [ 989.756291] Call Trace: [ 989.759828] [ 989.762978] __schedule+0xcc3/0x19c0 [ 989.767792] ? io_schedule_timeout+0x140/0x140 [ 989.773569] ? find_held_lock+0x2b/0x80 [ 989.778672] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.784558] schedule+0xd8/0x260 [ 989.788978] schedule_preempt_disabled+0x18/0x30 [ 989.794957] __mutex_lock+0x6af/0x2010 [ 989.799963] ? threaded_store+0x132/0x220 [ 989.805264] ? ww_mutex_lock+0x160/0x160 [ 989.810467] ? selinux_inode_free_security+0x330/0x330 [ 989.817035] ? cap_capable+0x1d6/0x3e0 [ 989.822044] ? threaded_store+0x132/0x220 [ 989.827338] threaded_store+0x132/0x220 [ 989.832440] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.837737] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.843036] ? sysfs_kf_write+0x65/0x160 [ 989.848236] ? sysfs_file_ops+0x140/0x140 [ 989.853531] kernfs_fop_write_iter+0x335/0x510 [ 989.859316] ? kernfs_ops+0xf0/0xf0 [ 989.864016] new_sync_write+0x333/0x750 [ 989.869118] ? __lock_acquire+0x508/0xc10 [ 989.874413] ? new_sync_read+0x740/0x740 [ 989.879614] ? lock_acquire.part.0+0xbc/0x260 [ 989.885299] ? ksys_write+0x116/0x250 [ 989.890207] vfs_write+0x657/0x9b0 [ 989.894812] ksys_write+0x116/0x250 [ 989.899524] ? __ia32_sys_read+0xc0/0xc0 [ 989.904722] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.910312] ? rcu_is_watching+0x15/0xd0 [ 989.915514] do_syscall_64+0xf3/0x650 [ 989.920419] ? trace_hardirqs_off+0xd/0x30 [ 989.925814] ? exc_page_fault+0xda/0xf0 [ 989.930915] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.937375] RIP: 0033:0x7f9fb36f764e [ 989.942184] RSP: 002b:00007ffe8aadfd10 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.951481] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9fb36f764e [ 989.960290] RDX: 0000000000000001 RSI: 00005613e3524420 RDI: 0000000000000007 [ 989.969097] RBP: 00007ffe8aadfd20 R08: 0000000000000000 R09: 0000000000000000 [ 989.977907] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9fb3570390 [ 989.986714] R13: 00005613e3524420 R14: 0000000000000007 R15: 00007f9fb3505120 | [ 990.397634] #1: ff11000187f22080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.408596] #2: ff11000121abcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.419753] #3: ff11000121b39d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.429832] | [ 990.432298] =============================================\x0a [ 1112.598905] INFO: task python3:5413 blocked for more than 245 seconds. [ 1112.607177] Not tainted 7.1.0-rc6-ohzb-g91a26bc64654 #1 [ 1112.614448] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.624035] task:python3 state:D stack:25672 pid:5413 tgid:5413 ppid:5411 task_flags:0x400100 flags:0x00080000 [ 1112.637240] Call Trace: [ 1112.640780] [ 1112.643931] __schedule+0xcc3/0x19c0 [ 1112.648745] ? io_schedule_timeout+0x140/0x140 [ 1112.654530] ? find_held_lock+0x2b/0x80 [ 1112.659633] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.665518] schedule+0xd8/0x260 [ 1112.669934] schedule_preempt_disabled+0x18/0x30 [ 1112.676012] __mutex_lock+0x6af/0x2010 [ 1112.681017] ? threaded_store+0x132/0x220 [ 1112.686318] ? ww_mutex_lock+0x160/0x160 [ 1112.691527] ? selinux_inode_free_security+0x330/0x330 [ 1112.698094] ? cap_capable+0x1d6/0x3e0 [ 1112.703103] ? threaded_store+0x132/0x220 [ 1112.708399] threaded_store+0x132/0x220 [ 1112.713498] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.718792] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.724087] ? sysfs_kf_write+0x65/0x160 [ 1112.729286] ? sysfs_file_ops+0x140/0x140 [ 1112.734579] kernfs_fop_write_iter+0x335/0x510 [ 1112.740363] ? kernfs_ops+0xf0/0xf0 [ 1112.745073] new_sync_write+0x333/0x750 [ 1112.750175] ? __lock_acquire+0x508/0xc10 [ 1112.755470] ? new_sync_read+0x740/0x740 [ 1112.760669] ? lock_acquire.part.0+0xbc/0x260 [ 1112.766353] ? ksys_write+0x116/0x250 [ 1112.771261] vfs_write+0x657/0x9b0 [ 1112.775876] ksys_write+0x116/0x250 [ 1112.780580] ? __ia32_sys_read+0xc0/0xc0 [ 1112.785767] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.791353] ? rcu_is_watching+0x15/0xd0 [ 1112.796553] do_syscall_64+0xf3/0x650 [ 1112.801456] ? trace_hardirqs_off+0xd/0x30 [ 1112.806851] ? exc_page_fault+0xda/0xf0 [ 1112.811953] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.818413] RIP: 0033:0x7f9fb36f764e [ 1112.823223] RSP: 002b:00007ffe8aadfd10 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.832512] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9fb36f764e [ 1112.841317] RDX: 0000000000000001 RSI: 00005613e3524420 RDI: 0000000000000007 [ 1112.850124] RBP: 00007ffe8aadfd20 R08: 0000000000000000 R09: 0000000000000000 [ 1112.858930] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9fb3570390 [ 1112.867734] R13: 00005613e3524420 R14: 0000000000000007 R15: 00007f9fb3505120 | [ 1113.249890] #2: ff11000121abcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.261048] #3: ff11000121b39d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.271135] | [ 1113.273628] =============================================\x0a | [ 1190.423860] kworker/u129:6 (283) used greatest stack depth: 21456 bytes left [ 1235.480178] INFO: task python3:5413 blocked for more than 368 seconds. [ 1235.488326] Not tainted 7.1.0-rc6-ohzb-g91a26bc64654 #1 [ 1235.495578] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.505166] task:python3 state:D stack:25672 pid:5413 tgid:5413 ppid:5411 task_flags:0x400100 flags:0x00080002 [ 1235.518369] Call Trace: [ 1235.521908] [ 1235.525056] __schedule+0xcc3/0x19c0 [ 1235.529873] ? io_schedule_timeout+0x140/0x140 [ 1235.535659] ? find_held_lock+0x2b/0x80 [ 1235.540763] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.546645] schedule+0xd8/0x260 [ 1235.551062] schedule_preempt_disabled+0x18/0x30 [ 1235.557038] __mutex_lock+0x6af/0x2010 [ 1235.562042] ? threaded_store+0x132/0x220 [ 1235.567341] ? ww_mutex_lock+0x160/0x160 [ 1235.572530] ? selinux_inode_free_security+0x330/0x330 [ 1235.579092] ? cap_capable+0x1d6/0x3e0 [ 1235.584096] ? threaded_store+0x132/0x220 [ 1235.589394] threaded_store+0x132/0x220 [ 1235.594487] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.599781] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.605082] ? sysfs_kf_write+0x65/0x160 [ 1235.610282] ? sysfs_file_ops+0x140/0x140 [ 1235.615574] kernfs_fop_write_iter+0x335/0x510 [ 1235.621359] ? kernfs_ops+0xf0/0xf0 [ 1235.626070] new_sync_write+0x333/0x750 [ 1235.631171] ? __lock_acquire+0x508/0xc10 [ 1235.636467] ? new_sync_read+0x740/0x740 [ 1235.641669] ? lock_acquire.part.0+0xbc/0x260 [ 1235.647351] ? ksys_write+0x116/0x250 [ 1235.652261] vfs_write+0x657/0x9b0 [ 1235.656874] ksys_write+0x116/0x250 [ 1235.661587] ? __ia32_sys_read+0xc0/0xc0 [ 1235.666786] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.672373] ? rcu_is_watching+0x15/0xd0 [ 1235.677572] do_syscall_64+0xf3/0x650 [ 1235.682477] ? trace_hardirqs_off+0xd/0x30 [ 1235.687872] ? exc_page_fault+0xda/0xf0 [ 1235.692976] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.699442] RIP: 0033:0x7f9fb36f764e [ 1235.704248] RSP: 002b:00007ffe8aadfd10 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.713546] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9fb36f764e [ 1235.722353] RDX: 0000000000000001 RSI: 00005613e3524420 RDI: 0000000000000007 [ 1235.731158] RBP: 00007ffe8aadfd20 R08: 0000000000000000 R09: 0000000000000000 [ 1235.739965] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9fb3570390 [ 1235.748769] R13: 00005613e3524420 R14: 0000000000000007 R15: 00007f9fb3505120 | [ 1236.159687] #1: ff11000187f22080 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1236.170648] #2: ff11000121abcb50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1236.181794] #3: ff11000121b39d68 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1236.191884] | [ 1236.194347] =============================================\x0a [ 1358.361498] INFO: task python3:5413 blocked for more than 491 seconds. [ 1358.369648] Not tainted 7.1.0-rc6-ohzb-g91a26bc64654 #1 [ 1358.376901] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.386486] task:python3 state:D stack:25672 pid:5413 tgid:5413 ppid:5411 task_flags:0x400100 flags:0x00080002 [ 1358.399693] Call Trace: [ 1358.403234] [ 1358.406385] __schedule+0xcc3/0x19c0 [ 1358.411204] ? io_schedule_timeout+0x140/0x140 [ 1358.416990] ? find_held_lock+0x2b/0x80 [ 1358.422098] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.427983] schedule+0xd8/0x260 [ 1358.432401] schedule_preempt_disabled+0x18/0x30 [ 1358.438383] __mutex_lock+0x6af/0x2010 [ 1358.443387] ? threaded_store+0x132/0x220 [ 1358.448678] ? ww_mutex_lock+0x160/0x160 [ 1358.453880] ? selinux_inode_free_security+0x330/0x330 [ 1358.460450] ? cap_capable+0x1d6/0x3e0 [ 1358.465460] ? threaded_store+0x132/0x220 [ 1358.470755] threaded_store+0x132/0x220 [ 1358.475856] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.481155] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.486453] ? sysfs_kf_write+0x65/0x160 [ 1358.491655] ? sysfs_file_ops+0x140/0x140 [ 1358.496952] kernfs_fop_write_iter+0x335/0x510 [ 1358.502737] ? kernfs_ops+0xf0/0xf0 [ 1358.507452] new_sync_write+0x333/0x750 [ 1358.512559] ? __lock_acquire+0x508/0xc10 [ 1358.517855] ? new_sync_read+0x740/0x740 [ 1358.523057] ? lock_acquire.part.0+0xbc/0x260 [ 1358.528745] ? ksys_write+0x116/0x250 [ 1358.533655] vfs_write+0x657/0x9b0 [ 1358.538272] ksys_write+0x116/0x250 [ 1358.542982] ? __ia32_sys_read+0xc0/0xc0 [ 1358.548180] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.553771] ? rcu_is_watching+0x15/0xd0 [ 1358.558974] do_syscall_64+0xf3/0x650 [ 1358.563879] ? trace_hardirqs_off+0xd/0x30 [ 1358.569275] ? exc_page_fault+0xda/0xf0 [ 1358.574379] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.580849] RIP: 0033:0x7f9fb36f764e [ 1358.585661] RSP: 002b:00007ffe8aadfd10 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.594959] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9fb36f764e [ 1358.603770] RDX: 0000000000000001 RSI: 00005613e3524420 RDI: 0000000000000007 [ 1358.612579] RBP: 00007ffe8aadfd20 R08: 0000000000000000 R09: 0000000000000000 [ 1358.621389] R10: 0000000000000000 R11: 0000000000000202 R12: 00007f9fb3570390 [ 1358.630199] R13: 00005613e3524420 R14: 0000000000000007 R15: 00007f9fb3505120 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store