====================================== | [ 787.674965] nipa-hw-worker: drivers/net:napi_threaded.py: timed out | [ 787.677952] nipa-hw-worker: [5/44] Retrying drivers/net:napi_threaded.py | [ 787.803410] kselftest: Running tests in drivers/net [ 989.700670] INFO: task python3:5943 blocked for more than 122 seconds. [ 989.708888] Not tainted 7.1.0-rc1-pmpt-g087fd7c22a0c #1 [ 989.716692] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 989.726285] task:python3 state:D stack:25672 pid:5943 tgid:5943 ppid:5942 task_flags:0x400100 flags:0x00080000 [ 989.739590] Call Trace: [ 989.743129] [ 989.746282] __schedule+0xcba/0x1940 [ 989.751099] ? io_schedule_timeout+0x140/0x140 [ 989.756883] ? find_held_lock+0x2b/0x80 [ 989.761978] ? __lock_release.isra.0+0x6b/0x1a0 [ 989.767867] schedule+0xd4/0x260 [ 989.772286] schedule_preempt_disabled+0x18/0x30 [ 989.778264] __mutex_lock+0x6a3/0x2000 [ 989.783270] ? threaded_store+0x132/0x220 [ 989.788570] ? ww_mutex_lock+0x160/0x160 [ 989.793768] ? selinux_inode_free_security+0x330/0x330 [ 989.800340] ? cap_capable+0x1d6/0x3e0 [ 989.805346] ? threaded_store+0x132/0x220 [ 989.810640] threaded_store+0x132/0x220 [ 989.815744] ? xps_rxqs_store+0x2e0/0x2e0 [ 989.821043] ? sysfs_file_kobj+0xbd/0x1e0 [ 989.826344] ? sysfs_kf_write+0x65/0x160 [ 989.831546] ? sysfs_file_ops+0x140/0x140 [ 989.836840] kernfs_fop_write_iter+0x335/0x510 [ 989.842626] ? kernfs_ops+0xf0/0xf0 [ 989.847339] new_sync_write+0x333/0x750 [ 989.852441] ? __lock_acquire+0x508/0xc10 [ 989.857739] ? new_sync_read+0x740/0x740 [ 989.862939] ? lock_acquire.part.0+0xbc/0x260 [ 989.868618] ? ksys_write+0x116/0x250 [ 989.873530] vfs_write+0x657/0x9b0 [ 989.878146] ksys_write+0x116/0x250 [ 989.882857] ? __ia32_sys_read+0xc0/0xc0 [ 989.888056] ? kernfs_fop_llseek+0x160/0x1f0 [ 989.893644] ? rcu_is_watching+0x15/0xd0 [ 989.898846] do_syscall_64+0xf3/0x650 [ 989.903753] ? trace_hardirqs_off+0xd/0x30 [ 989.909139] ? exc_page_fault+0xda/0xf0 [ 989.914244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 989.920710] RIP: 0033:0x7ff3c821e22e [ 989.925519] RSP: 002b:00007ffcc8dd5d50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 989.934816] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff3c821e22e [ 989.943623] RDX: 0000000000000001 RSI: 000055c742c7e410 RDI: 0000000000000007 [ 989.952430] RBP: 00007ffcc8dd5d60 R08: 0000000000000000 R09: 0000000000000000 [ 989.961241] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff3c8096390 [ 989.970060] R13: 000055c742c7e410 R14: 0000000000000007 R15: 0000000000000003 | [ 990.387264] #1: ff110001e6cfdc80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 990.398227] #2: ff110001230e2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 990.409385] #3: ff11000123159d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 990.419471] | [ 990.421940] =============================================\x0a [ 1112.582788] INFO: task python3:5943 blocked for more than 245 seconds. [ 1112.590938] Not tainted 7.1.0-rc1-pmpt-g087fd7c22a0c #1 [ 1112.598190] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1112.607781] task:python3 state:D stack:25672 pid:5943 tgid:5943 ppid:5942 task_flags:0x400100 flags:0x00080000 [ 1112.620988] Call Trace: [ 1112.624529] [ 1112.627678] __schedule+0xcba/0x1940 [ 1112.632498] ? io_schedule_timeout+0x140/0x140 [ 1112.638282] ? find_held_lock+0x2b/0x80 [ 1112.643391] ? __lock_release.isra.0+0x6b/0x1a0 [ 1112.649275] schedule+0xd4/0x260 [ 1112.653687] schedule_preempt_disabled+0x18/0x30 [ 1112.659664] __mutex_lock+0x6a3/0x2000 [ 1112.664669] ? threaded_store+0x132/0x220 [ 1112.669971] ? ww_mutex_lock+0x160/0x160 [ 1112.675171] ? selinux_inode_free_security+0x330/0x330 [ 1112.681740] ? cap_capable+0x1d6/0x3e0 [ 1112.686750] ? threaded_store+0x132/0x220 [ 1112.692050] threaded_store+0x132/0x220 [ 1112.697152] ? xps_rxqs_store+0x2e0/0x2e0 [ 1112.702450] ? sysfs_file_kobj+0xbd/0x1e0 [ 1112.707748] ? sysfs_kf_write+0x65/0x160 [ 1112.712948] ? sysfs_file_ops+0x140/0x140 [ 1112.718247] kernfs_fop_write_iter+0x335/0x510 [ 1112.724034] ? kernfs_ops+0xf0/0xf0 [ 1112.728745] new_sync_write+0x333/0x750 [ 1112.733850] ? __lock_acquire+0x508/0xc10 [ 1112.739140] ? new_sync_read+0x740/0x740 [ 1112.744342] ? lock_acquire.part.0+0xbc/0x260 [ 1112.750030] ? ksys_write+0x116/0x250 [ 1112.754940] vfs_write+0x657/0x9b0 [ 1112.759557] ksys_write+0x116/0x250 [ 1112.764269] ? __ia32_sys_read+0xc0/0xc0 [ 1112.769468] ? kernfs_fop_llseek+0x160/0x1f0 [ 1112.775059] ? rcu_is_watching+0x15/0xd0 [ 1112.780259] do_syscall_64+0xf3/0x650 [ 1112.785168] ? trace_hardirqs_off+0xd/0x30 [ 1112.790565] ? exc_page_fault+0xda/0xf0 [ 1112.795668] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1112.802139] RIP: 0033:0x7ff3c821e22e [ 1112.806949] RSP: 002b:00007ffcc8dd5d50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1112.816237] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff3c821e22e [ 1112.825038] RDX: 0000000000000001 RSI: 000055c742c7e410 RDI: 0000000000000007 [ 1112.833848] RBP: 00007ffcc8dd5d60 R08: 0000000000000000 R09: 0000000000000000 [ 1112.842657] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff3c8096390 [ 1112.851467] R13: 000055c742c7e410 R14: 0000000000000007 R15: 0000000000000003 | [ 1113.228333] #1: ff110001e6cfdc80 (&of->mutex#2){+.+.}-{4:4}, at: kernfs_fop_write_iter+0x248/0x510 | [ 1113.239294] #2: ff110001230e2b50 (kn->active#118){.+.+}-{0:0}, at: kernfs_fop_write_iter+0x29e/0x510 | [ 1113.250446] #3: ff11000123159d60 (&dev->lock){+.+.}-{4:4}, at: threaded_store+0x132/0x220 | [ 1113.260537] | [ 1113.263004] =============================================\x0a [ 1235.462946] INFO: task python3:5943 blocked for more than 368 seconds. [ 1235.471095] Not tainted 7.1.0-rc1-pmpt-g087fd7c22a0c #1 [ 1235.478347] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1235.487938] task:python3 state:D stack:25672 pid:5943 tgid:5943 ppid:5942 task_flags:0x400100 flags:0x00080002 [ 1235.501143] Call Trace: [ 1235.504682] [ 1235.507832] __schedule+0xcba/0x1940 [ 1235.512653] ? io_schedule_timeout+0x140/0x140 [ 1235.518439] ? find_held_lock+0x2b/0x80 [ 1235.523546] ? __lock_release.isra.0+0x6b/0x1a0 [ 1235.529432] schedule+0xd4/0x260 [ 1235.533853] schedule_preempt_disabled+0x18/0x30 [ 1235.539830] __mutex_lock+0x6a3/0x2000 [ 1235.544837] ? threaded_store+0x132/0x220 [ 1235.550139] ? ww_mutex_lock+0x160/0x160 [ 1235.555338] ? selinux_inode_free_security+0x330/0x330 [ 1235.561908] ? cap_capable+0x1d6/0x3e0 [ 1235.566916] ? threaded_store+0x132/0x220 [ 1235.572213] threaded_store+0x132/0x220 [ 1235.577313] ? xps_rxqs_store+0x2e0/0x2e0 [ 1235.577318] ? sysfs_file_kobj+0xbd/0x1e0 [ 1235.577323] ? sysfs_kf_write+0x65/0x160 [ 1235.577327] ? sysfs_file_ops+0x140/0x140 [ 1235.577329] kernfs_fop_write_iter+0x335/0x510 [ 1235.604231] ? kernfs_ops+0xf0/0xf0 [ 1235.608941] new_sync_write+0x333/0x750 [ 1235.614047] ? __lock_acquire+0x508/0xc10 [ 1235.619345] ? new_sync_read+0x740/0x740 [ 1235.624545] ? lock_acquire.part.0+0xbc/0x260 [ 1235.630233] ? ksys_write+0x116/0x250 [ 1235.635146] vfs_write+0x657/0x9b0 [ 1235.639760] ksys_write+0x116/0x250 [ 1235.644472] ? __ia32_sys_read+0xc0/0xc0 [ 1235.649671] ? kernfs_fop_llseek+0x160/0x1f0 [ 1235.655259] ? rcu_is_watching+0x15/0xd0 [ 1235.660454] do_syscall_64+0xf3/0x650 [ 1235.665362] ? trace_hardirqs_off+0xd/0x30 [ 1235.670757] ? exc_page_fault+0xda/0xf0 [ 1235.675859] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1235.682327] RIP: 0033:0x7ff3c821e22e [ 1235.687127] RSP: 002b:00007ffcc8dd5d50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1235.696424] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff3c821e22e [ 1235.705232] RDX: 0000000000000001 RSI: 000055c742c7e410 RDI: 0000000000000007 [ 1235.714040] RBP: 00007ffcc8dd5d60 R08: 0000000000000000 R09: 0000000000000000 [ 1235.722840] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff3c8096390 [ 1235.731647] R13: 000055c742c7e410 R14: 0000000000000007 R15: 0000000000000003 | [ 1236.207907] #2: ffffffff88d69c20 (cgroup_mutex){+.+.}-{4:4}, at: cgroup_kn_lock_live+0xe2/0x3e0 | [ 1236.218574] #3: ffffffff88b68970 (cpu_hotplug_lock){++++}-{0:0}, at: cgroup_procs_write_start+0x3e5/0x6b0 | [ 1236.230217] #4: ffffffff88d69990 (cgroup_threadgroup_rwsem){++++}-{0:0}, at: cgroup_procs_write_start+0x3f1/0x6b0 | [ 1236.242641] | [ 1236.245105] =============================================\x0a [ 1358.345037] INFO: task python3:5943 blocked for more than 491 seconds. [ 1358.353185] Not tainted 7.1.0-rc1-pmpt-g087fd7c22a0c #1 [ 1358.360436] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1358.370028] task:python3 state:D stack:25672 pid:5943 tgid:5943 ppid:5942 task_flags:0x400100 flags:0x00080002 [ 1358.383236] Call Trace: [ 1358.386776] [ 1358.389930] __schedule+0xcba/0x1940 [ 1358.394747] ? io_schedule_timeout+0x140/0x140 [ 1358.400534] ? find_held_lock+0x2b/0x80 [ 1358.405641] ? __lock_release.isra.0+0x6b/0x1a0 [ 1358.411525] schedule+0xd4/0x260 [ 1358.415944] schedule_preempt_disabled+0x18/0x30 [ 1358.421925] __mutex_lock+0x6a3/0x2000 [ 1358.426933] ? threaded_store+0x132/0x220 [ 1358.432231] ? ww_mutex_lock+0x160/0x160 [ 1358.437431] ? selinux_inode_free_security+0x330/0x330 [ 1358.444000] ? cap_capable+0x1d6/0x3e0 [ 1358.449009] ? threaded_store+0x132/0x220 [ 1358.454306] threaded_store+0x132/0x220 [ 1358.459399] ? xps_rxqs_store+0x2e0/0x2e0 [ 1358.464698] ? sysfs_file_kobj+0xbd/0x1e0 [ 1358.469999] ? sysfs_kf_write+0x65/0x160 [ 1358.475199] ? sysfs_file_ops+0x140/0x140 [ 1358.480486] kernfs_fop_write_iter+0x335/0x510 [ 1358.486270] ? kernfs_ops+0xf0/0xf0 [ 1358.490981] new_sync_write+0x333/0x750 [ 1358.496085] ? __lock_acquire+0x508/0xc10 [ 1358.501381] ? new_sync_read+0x740/0x740 [ 1358.506584] ? lock_acquire.part.0+0xbc/0x260 [ 1358.512270] ? ksys_write+0x116/0x250 [ 1358.517179] vfs_write+0x657/0x9b0 [ 1358.521797] ksys_write+0x116/0x250 [ 1358.526510] ? __ia32_sys_read+0xc0/0xc0 [ 1358.531708] ? kernfs_fop_llseek+0x160/0x1f0 [ 1358.537298] ? rcu_is_watching+0x15/0xd0 [ 1358.542498] do_syscall_64+0xf3/0x650 [ 1358.547407] ? trace_hardirqs_off+0xd/0x30 [ 1358.552803] ? exc_page_fault+0xda/0xf0 [ 1358.557906] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1358.564377] RIP: 0033:0x7ff3c821e22e [ 1358.569187] RSP: 002b:00007ffcc8dd5d50 EFLAGS: 00000202 ORIG_RAX: 0000000000000001 [ 1358.578485] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff3c821e22e [ 1358.587295] RDX: 0000000000000001 RSI: 000055c742c7e410 RDI: 0000000000000007 [ 1358.596104] RBP: 00007ffcc8dd5d60 R08: 0000000000000000 R09: 0000000000000000 [ 1358.604913] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ff3c8096390 [ 1358.613721] R13: 000055c742c7e410 R14: 0000000000000007 R15: 0000000000000003 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:threaded_store