FAULT_INJECTION: forcing a failure. name fail_usercopy, interval 1, probability 0, space 0, times 0 ====================================================== WARNING: possible circular locking dependency detected syzkaller #0 Not tainted ------------------------------------------------------ syz.9.311/8483 is trying to acquire lock: ffffffff8cd24120 (console_owner){-.-.}-{0:0}, at: rcu_try_lock_acquire include/linux/rcupdate.h:339 [inline] ffffffff8cd24120 (console_owner){-.-.}-{0:0}, at: srcu_read_lock_nmisafe include/linux/srcu.h:232 [inline] ffffffff8cd24120 (console_owner){-.-.}-{0:0}, at: console_srcu_read_lock kernel/printk/printk.c:292 [inline] ffffffff8cd24120 (console_owner){-.-.}-{0:0}, at: console_flush_all+0x10f/0xd00 kernel/printk/printk.c:2992 but task is already holding lock: ffff8880b8e3c018 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0xad/0x140 kernel/sched/core.c:566 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #4 (&rq->__lock){-.-.}-{2:2}: _raw_spin_lock_nested+0x32/0x50 kernel/locking/spinlock.c:378 raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:558 raw_spin_rq_lock kernel/sched/sched.h:1372 [inline] rq_lock kernel/sched/sched.h:1681 [inline] task_fork_fair+0x62/0x1f0 kernel/sched/fair.c:12688 sched_cgroup_fork+0x333/0x3c0 kernel/sched/core.c:4816 copy_process+0x21e4/0x3d70 kernel/fork.c:2614 kernel_clone+0x21b/0x840 kernel/fork.c:2914 user_mode_thread+0xde/0x130 kernel/fork.c:2992 rest_init+0x27/0x300 init/main.c:709 arch_call_rest_init+0xe/0x10 init/main.c:841 start_kernel+0x459/0x4e0 init/main.c:1086 x86_64_start_reservations+0x2a/0x30 arch/x86/kernel/head64.c:555 copy_bootdata+0x0/0xe0 arch/x86/kernel/head64.c:536 secondary_startup_64_no_verify+0x179/0x17b -> #3 (&p->pi_lock){-.-.}-{2:2}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0xa8/0xf0 kernel/locking/spinlock.c:162 class_raw_spinlock_irqsave_constructor include/linux/spinlock.h:522 [inline] try_to_wake_up+0x60/0x1140 kernel/sched/core.c:4232 __wake_up_common+0x2a4/0x4e0 kernel/sched/wait.c:107 __wake_up_common_lock kernel/sched/wait.c:138 [inline] __wake_up+0x112/0x190 kernel/sched/wait.c:160 tty_port_default_wakeup+0xa2/0xf0 drivers/tty/tty_port.c:69 serial8250_tx_chars+0x6bd/0x8a0 drivers/tty/serial/8250/8250_port.c:1837 serial8250_handle_irq+0x534/0x6e0 drivers/tty/serial/8250/8250_port.c:1944 serial8250_default_handle_irq+0xb8/0x1a0 drivers/tty/serial/8250/8250_port.c:1964 serial8250_interrupt+0x9f/0x1c0 drivers/tty/serial/8250/8250_core.c:127 __handle_irq_event_percpu+0x276/0x930 kernel/irq/handle.c:158 handle_irq_event_percpu kernel/irq/handle.c:193 [inline] handle_irq_event+0x8b/0x1e0 kernel/irq/handle.c:210 handle_edge_irq+0x247/0xb30 kernel/irq/chip.c:831 generic_handle_irq_desc include/linux/irqdesc.h:161 [inline] handle_irq arch/x86/kernel/irq.c:240 [inline] __common_interrupt+0x13b/0x230 arch/x86/kernel/irq.c:259 common_interrupt+0xb4/0xd0 arch/x86/kernel/irq.c:249 asm_common_interrupt+0x26/0x40 arch/x86/include/asm/idtentry.h:678 kasan_check_range+0x1c0/0x290 mm/kasan/generic.c:-1 instrument_atomic_read include/linux/instrumented.h:68 [inline] _test_bit include/asm-generic/bitops/instrumented-non-atomic.h:141 [inline] cpumask_test_cpu include/linux/cpumask.h:504 [inline] cpu_online include/linux/cpumask.h:1082 [inline] trace_lock_release include/trace/events/lock.h:69 [inline] lock_release+0xab/0x8b0 kernel/locking/lockdep.c:5765 rcu_lock_release include/linux/rcupdate.h:344 [inline] rcu_read_unlock include/linux/rcupdate.h:819 [inline] is_bpf_text_address+0x28f/0x2a0 kernel/bpf/core.c:743 kernel_text_address+0xa0/0xd0 kernel/extable.c:125 __kernel_text_address+0xd/0x30 kernel/extable.c:79 unwind_get_return_address+0x5d/0xc0 arch/x86/kernel/unwind_orc.c:369 arch_stack_walk+0x11d/0x190 arch/x86/kernel/stacktrace.c:26 stack_trace_save+0x9c/0xe0 kernel/stacktrace.c:122 kasan_save_stack mm/kasan/common.c:45 [inline] kasan_set_track+0x4e/0x70 mm/kasan/common.c:52 kasan_save_free_info+0x2e/0x50 mm/kasan/generic.c:522 ____kasan_slab_free+0x126/0x1e0 mm/kasan/common.c:236 kasan_slab_free include/linux/kasan.h:164 [inline] slab_free_hook mm/slub.c:1811 [inline] slab_free_freelist_hook+0x130/0x1b0 mm/slub.c:1837 slab_free mm/slub.c:3830 [inline] __kmem_cache_free+0xba/0x1f0 mm/slub.c:3843 tomoyo_check_open_permission+0x2d3/0x3c0 security/tomoyo/file.c:786 security_file_open+0x62/0xa0 security/security.c:2854 do_dentry_open+0x380/0x1500 fs/open.c:916 do_open fs/namei.c:3640 [inline] path_openat+0x274b/0x3190 fs/namei.c:3797 do_filp_open+0x1c5/0x3d0 fs/namei.c:3824 do_sys_openat2+0x12c/0x1c0 fs/open.c:1421 do_sys_open fs/open.c:1436 [inline] __do_sys_openat fs/open.c:1452 [inline] __se_sys_openat fs/open.c:1447 [inline] __x64_sys_openat+0x139/0x160 fs/open.c:1447 do_syscall_x64 arch/x86/entry/common.c:51 [inline] do_syscall_64+0x55/0xb0 arch/x86/entry/common.c:81 entry_SYSCALL_64_after_hwframe+0x68/0xd2 -> #2 (&tty->write_wait){-...}-{2:2}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0xa8/0xf0 kernel/locking/spinlock.c:162 __wake_up_common_lock kernel/sched/wait.c:137 [inline] __wake_up+0xf8/0x190 kernel/sched/wait.c:160 tty_port_default_wakeup+0xa2/0xf0 drivers/tty/tty_port.c:69 serial8250_tx_chars+0x6bd/0x8a0 drivers/tty/serial/8250/8250_port.c:1837 serial8250_handle_irq+0x534/0x6e0 drivers/tty/serial/8250/8250_port.c:1944 serial8250_default_handle_irq+0xb8/0x1a0 drivers/tty/serial/8250/8250_port.c:1964 serial8250_interrupt+0x9f/0x1c0 drivers/tty/serial/8250/8250_core.c:127 __handle_irq_event_percpu+0x276/0x930 kernel/irq/handle.c:158 handle_irq_event_percpu kernel/irq/handle.c:193 [inline] handle_irq_event+0x8b/0x1e0 kernel/irq/handle.c:210 handle_edge_irq+0x247/0xb30 kernel/irq/chip.c:831 generic_handle_irq_desc include/linux/irqdesc.h:161 [inline] handle_irq arch/x86/kernel/irq.c:240 [inline] __common_interrupt+0x13b/0x230 arch/x86/kernel/irq.c:259 common_interrupt+0xb4/0xd0 arch/x86/kernel/irq.c:249 asm_common_interrupt+0x26/0x40 arch/x86/include/asm/idtentry.h:678 native_safe_halt arch/x86/include/asm/irqflags.h:48 [inline] pv_native_safe_halt+0x13/0x20 arch/x86/kernel/paravirt.c:147 arch_safe_halt arch/x86/include/asm/paravirt.h:108 [inline] default_idle+0x13/0x20 arch/x86/kernel/process.c:753 default_idle_call+0x6c/0xa0 kernel/sched/idle.c:97 cpuidle_idle_call kernel/sched/idle.c:170 [inline] do_idle+0x1eb/0x510 kernel/sched/idle.c:282 cpu_startup_entry+0x43/0x60 kernel/sched/idle.c:380 rest_init+0x2e2/0x300 init/main.c:744 arch_call_rest_init+0xe/0x10 init/main.c:841 start_kernel+0x459/0x4e0 init/main.c:1086 x86_64_start_reservations+0x2a/0x30 arch/x86/kernel/head64.c:555 copy_bootdata+0x0/0xe0 arch/x86/kernel/head64.c:536 secondary_startup_64_no_verify+0x179/0x17b -> #1 (&port_lock_key){-.-.}-{2:2}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0xa8/0xf0 kernel/locking/spinlock.c:162 serial8250_console_write+0x16d/0x17a0 drivers/tty/serial/8250/8250_port.c:3433 console_emit_next_record kernel/printk/printk.c:2944 [inline] console_flush_all+0x6cd/0xd00 kernel/printk/printk.c:3000 console_unlock+0xae/0x340 kernel/printk/printk.c:3069 vprintk_emit+0x477/0x600 kernel/printk/printk.c:2341 _printk+0xd0/0x110 kernel/printk/printk.c:2366 register_console+0x91b/0xe60 kernel/printk/printk.c:3583 univ8250_console_init+0x45/0x50 drivers/tty/serial/8250/8250_core.c:717 console_init+0x17b/0x5e0 kernel/printk/printk.c:3726 start_kernel+0x2c0/0x4e0 init/main.c:1022 x86_64_start_reservations+0x2a/0x30 arch/x86/kernel/head64.c:555 copy_bootdata+0x0/0xe0 arch/x86/kernel/head64.c:536 secondary_startup_64_no_verify+0x179/0x17b -> #0 (console_owner){-.-.}-{0:0}: check_prev_add kernel/locking/lockdep.c:3134 [inline] check_prevs_add kernel/locking/lockdep.c:3253 [inline] validate_chain kernel/locking/lockdep.c:3869 [inline] __lock_acquire+0x2ddb/0x7c80 kernel/locking/lockdep.c:5137 lock_acquire+0x197/0x410 kernel/locking/lockdep.c:5754 console_lock_spinning_enable kernel/printk/printk.c:1871 [inline] console_emit_next_record kernel/printk/printk.c:2938 [inline] console_flush_all+0x693/0xd00 kernel/printk/printk.c:3000 console_unlock+0xae/0x340 kernel/printk/printk.c:3069 vprintk_emit+0x477/0x600 kernel/printk/printk.c:2341 _printk+0xd0/0x110 kernel/printk/printk.c:2366 fail_dump lib/fault-inject.c:45 [inline] should_fail_ex+0x37e/0x4d0 lib/fault-inject.c:153 strncpy_from_user+0x36/0x2e0 lib/strncpy_from_user.c:118 strncpy_from_user_nofault+0x71/0x140 mm/maccess.c:186 bpf_trace_copy_string kernel/bpf/helpers.c:755 [inline] bpf_bprintf_prepare+0xb9b/0x1400 kernel/bpf/helpers.c:980 ____bpf_trace_printk kernel/trace/bpf_trace.c:381 [inline] bpf_trace_printk+0xdc/0x190 kernel/trace/bpf_trace.c:371 bpf_prog_7c77c7e0f6645ad8+0x3d/0x3f bpf_dispatcher_nop_func include/linux/bpf.h:1224 [inline] __bpf_prog_run include/linux/filter.h:612 [inline] bpf_prog_run include/linux/filter.h:619 [inline] __bpf_trace_run kernel/trace/bpf_trace.c:2322 [inline] bpf_trace_run2+0x1d1/0x3c0 kernel/trace/bpf_trace.c:2361 __bpf_trace_contention_begin+0xdd/0x130 include/trace/events/lock.h:95 trace_contention_begin+0xe9/0x110 include/trace/events/lock.h:95 __pv_queued_spin_lock_slowpath+0xe0/0x9d0 kernel/locking/qspinlock.c:405 pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:586 [inline] queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline] queued_spin_lock include/asm-generic/qspinlock.h:114 [inline] do_raw_spin_lock+0x24e/0x2c0 kernel/locking/spinlock_debug.c:115 raw_spin_rq_lock_nested+0xad/0x140 kernel/sched/core.c:566 raw_spin_rq_lock kernel/sched/sched.h:1372 [inline] rq_lock kernel/sched/sched.h:1681 [inline] __schedule+0x2dd/0x44d0 kernel/sched/core.c:6613 preempt_schedule_common+0x82/0xc0 kernel/sched/core.c:6866 preempt_schedule+0xab/0xc0 kernel/sched/core.c:6890 preempt_schedule_thunk+0x1a/0x30 arch/x86/entry/thunk_64.S:45 __raw_spin_unlock include/linux/spinlock_api_smp.h:143 [inline] _raw_spin_unlock+0x3a/0x40 kernel/locking/spinlock.c:186 spin_unlock include/linux/spinlock.h:391 [inline] nilfs_load_inode_block+0x271/0x340 fs/nilfs2/inode.c:1066 __nilfs_mark_inode_dirty+0x10c/0x2b0 fs/nilfs2/inode.c:1136 nilfs_dirty_inode+0x164/0x200 fs/nilfs2/inode.c:1177 __mark_inode_dirty+0x2cc/0xca0 fs/fs-writeback.c:2465 generic_update_time fs/inode.c:1981 [inline] inode_update_time fs/inode.c:1994 [inline] __file_update_time fs/inode.c:2180 [inline] file_update_time+0x197/0x1b0 fs/inode.c:2210 __generic_file_write_iter+0x9a/0x230 mm/filemap.c:4107 generic_file_write_iter+0xaf/0x2e0 mm/filemap.c:4152 call_write_iter include/linux/fs.h:2018 [inline] new_sync_write fs/read_write.c:491 [inline] vfs_write+0x43b/0x940 fs/read_write.c:584 ksys_write+0x147/0x250 fs/read_write.c:637 do_syscall_x64 arch/x86/entry/common.c:51 [inline] do_syscall_64+0x55/0xb0 arch/x86/entry/common.c:81 entry_SYSCALL_64_after_hwframe+0x68/0xd2 other info that might help us debug this: Chain exists of: console_owner --> &p->pi_lock --> &rq->__lock Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&rq->__lock); lock(&p->pi_lock); lock(&rq->__lock); lock(console_owner); *** DEADLOCK *** 9 locks held by syz.9.311/8483: #0: ffff88807cd95748 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x2a3/0x330 fs/file.c:1040 #1: ffff888057abe418 (sb_writers#25){.+.+}-{0:0}, at: vfs_write+0x20e/0x940 fs/read_write.c:580 #2: ffff888057e635f8 (&sb->s_type->i_mutex_key#27){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:804 [inline] #2: ffff888057e635f8 (&sb->s_type->i_mutex_key#27){+.+.}-{3:3}, at: generic_file_write_iter+0x83/0x2e0 mm/filemap.c:4149 #3: ffff888057abe608 (sb_internal#5){.+.+}-{0:0}, at: nilfs_dirty_inode+0x158/0x200 fs/nilfs2/inode.c:1176 #4: ffff888078e622a0 (&nilfs->ns_segctor_sem){++++}-{3:3}, at: nilfs_transaction_begin+0x364/0x710 fs/nilfs2/segment.c:223 #5: ffff8880b8e3c018 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0xad/0x140 kernel/sched/core.c:566 #6: ffffffff8cd2fee0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:334 [inline] #6: ffffffff8cd2fee0 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:786 [inline] #6: ffffffff8cd2fee0 (rcu_read_lock){....}-{1:2}, at: __bpf_trace_run kernel/trace/bpf_trace.c:2321 [inline] #6: ffffffff8cd2fee0 (rcu_read_lock){....}-{1:2}, at: bpf_trace_run2+0xde/0x3c0 kernel/trace/bpf_trace.c:2361 #7: ffffffff8cd24200 (console_lock){+.+.}-{0:0}, at: _printk+0xd0/0x110 kernel/printk/printk.c:2366 #8: ffffffff8cc0ba10 (console_srcu){....}-{0:0}, at: rcu_try_lock_acquire include/linux/rcupdate.h:339 [inline] #8: ffffffff8cc0ba10 (console_srcu){....}-{0:0}, at: srcu_read_lock_nmisafe include/linux/srcu.h:232 [inline] #8: ffffffff8cc0ba10 (console_srcu){....}-{0:0}, at: console_srcu_read_lock kernel/printk/printk.c:292 [inline] #8: ffffffff8cc0ba10 (console_srcu){....}-{0:0}, at: console_flush_all+0x10f/0xd00 kernel/printk/printk.c:2992 stack backtrace: CPU: 0 PID: 8483 Comm: syz.9.311 Not tainted syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/02/2025 Call Trace: dump_stack_lvl+0x16c/0x230 lib/dump_stack.c:106 check_noncircular+0x2bd/0x3c0 kernel/locking/lockdep.c:2187 check_prev_add kernel/locking/lockdep.c:3134 [inline] check_prevs_add kernel/locking/lockdep.c:3253 [inline] validate_chain kernel/locking/lockdep.c:3869 [inline] __lock_acquire+0x2ddb/0x7c80 kernel/locking/lockdep.c:5137 lock_acquire+0x197/0x410 kernel/locking/lockdep.c:5754 console_lock_spinning_enable kernel/printk/printk.c:1871 [inline] console_emit_next_record kernel/printk/printk.c:2938 [inline] console_flush_all+0x693/0xd00 kernel/printk/printk.c:3000 console_unlock+0xae/0x340 kernel/printk/printk.c:3069 vprintk_emit+0x477/0x600 kernel/printk/printk.c:2341 _printk+0xd0/0x110 kernel/printk/printk.c:2366 fail_dump lib/fault-inject.c:45 [inline] should_fail_ex+0x37e/0x4d0 lib/fault-inject.c:153 strncpy_from_user+0x36/0x2e0 lib/strncpy_from_user.c:118 strncpy_from_user_nofault+0x71/0x140 mm/maccess.c:186 bpf_trace_copy_string kernel/bpf/helpers.c:755 [inline] bpf_bprintf_prepare+0xb9b/0x1400 kernel/bpf/helpers.c:980 ____bpf_trace_printk kernel/trace/bpf_trace.c:381 [inline] bpf_trace_printk+0xdc/0x190 kernel/trace/bpf_trace.c:371 bpf_prog_7c77c7e0f6645ad8+0x3d/0x3f bpf_dispatcher_nop_func include/linux/bpf.h:1224 [inline] __bpf_prog_run include/linux/filter.h:612 [inline] bpf_prog_run include/linux/filter.h:619 [inline] __bpf_trace_run kernel/trace/bpf_trace.c:2322 [inline] bpf_trace_run2+0x1d1/0x3c0 kernel/trace/bpf_trace.c:2361 __bpf_trace_contention_begin+0xdd/0x130 include/trace/events/lock.h:95 trace_contention_begin+0xe9/0x110 include/trace/events/lock.h:95 __pv_queued_spin_lock_slowpath+0xe0/0x9d0 kernel/locking/qspinlock.c:405 pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:586 [inline] queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline] queued_spin_lock include/asm-generic/qspinlock.h:114 [inline] do_raw_spin_lock+0x24e/0x2c0 kernel/locking/spinlock_debug.c:115 raw_spin_rq_lock_nested+0xad/0x140 kernel/sched/core.c:566 raw_spin_rq_lock kernel/sched/sched.h:1372 [inline] rq_lock kernel/sched/sched.h:1681 [inline] __schedule+0x2dd/0x44d0 kernel/sched/core.c:6613 preempt_schedule_common+0x82/0xc0 kernel/sched/core.c:6866 preempt_schedule+0xab/0xc0 kernel/sched/core.c:6890 preempt_schedule_thunk+0x1a/0x30 arch/x86/entry/thunk_64.S:45 __raw_spin_unlock include/linux/spinlock_api_smp.h:143 [inline] _raw_spin_unlock+0x3a/0x40 kernel/locking/spinlock.c:186 spin_unlock include/linux/spinlock.h:391 [inline] nilfs_load_inode_block+0x271/0x340 fs/nilfs2/inode.c:1066 __nilfs_mark_inode_dirty+0x10c/0x2b0 fs/nilfs2/inode.c:1136 nilfs_dirty_inode+0x164/0x200 fs/nilfs2/inode.c:1177 __mark_inode_dirty+0x2cc/0xca0 fs/fs-writeback.c:2465 generic_update_time fs/inode.c:1981 [inline] inode_update_time fs/inode.c:1994 [inline] __file_update_time fs/inode.c:2180 [inline] file_update_time+0x197/0x1b0 fs/inode.c:2210 __generic_file_write_iter+0x9a/0x230 mm/filemap.c:4107 generic_file_write_iter+0xaf/0x2e0 mm/filemap.c:4152 call_write_iter include/linux/fs.h:2018 [inline] new_sync_write fs/read_write.c:491 [inline] vfs_write+0x43b/0x940 fs/read_write.c:584 ksys_write+0x147/0x250 fs/read_write.c:637 do_syscall_x64 arch/x86/entry/common.c:51 [inline] do_syscall_64+0x55/0xb0 arch/x86/entry/common.c:81 entry_SYSCALL_64_after_hwframe+0x68/0xd2 RIP: 0033:0x7f0f3d98f749 Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48 RSP: 002b:00007f0f3e8c9038 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007f0f3dbe6090 RCX: 00007f0f3d98f749 RDX: 000000000208e24b RSI: 0000200000000040 RDI: 0000000000000007 RBP: 00007f0f3e8c9090 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000001 R13: 00007f0f3dbe6128 R14: 00007f0f3dbe6090 R15: 00007ffdb719e268 CPU: 0 PID: 8483 Comm: syz.9.311 Not tainted syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/02/2025 Call Trace: dump_stack_lvl+0x16c/0x230 lib/dump_stack.c:106 fail_dump lib/fault-inject.c:52 [inline] should_fail_ex+0x39d/0x4d0 lib/fault-inject.c:153 strncpy_from_user+0x36/0x2e0 lib/strncpy_from_user.c:118 strncpy_from_user_nofault+0x71/0x140 mm/maccess.c:186 bpf_trace_copy_string kernel/bpf/helpers.c:755 [inline] bpf_bprintf_prepare+0xb9b/0x1400 kernel/bpf/helpers.c:980 ____bpf_trace_printk kernel/trace/bpf_trace.c:381 [inline] bpf_trace_printk+0xdc/0x190 kernel/trace/bpf_trace.c:371 bpf_prog_7c77c7e0f6645ad8+0x3d/0x3f bpf_dispatcher_nop_func include/linux/bpf.h:1224 [inline] __bpf_prog_run include/linux/filter.h:612 [inline] bpf_prog_run include/linux/filter.h:619 [inline] __bpf_trace_run kernel/trace/bpf_trace.c:2322 [inline] bpf_trace_run2+0x1d1/0x3c0 kernel/trace/bpf_trace.c:2361 __bpf_trace_contention_begin+0xdd/0x130 include/trace/events/lock.h:95 trace_contention_begin+0xe9/0x110 include/trace/events/lock.h:95 __pv_queued_spin_lock_slowpath+0xe0/0x9d0 kernel/locking/qspinlock.c:405 pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:586 [inline] queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline] queued_spin_lock include/asm-generic/qspinlock.h:114 [inline] do_raw_spin_lock+0x24e/0x2c0 kernel/locking/spinlock_debug.c:115 raw_spin_rq_lock_nested+0xad/0x140 kernel/sched/core.c:566 raw_spin_rq_lock kernel/sched/sched.h:1372 [inline] rq_lock kernel/sched/sched.h:1681 [inline] __schedule+0x2dd/0x44d0 kernel/sched/core.c:6613 preempt_schedule_common+0x82/0xc0 kernel/sched/core.c:6866 preempt_schedule+0xab/0xc0 kernel/sched/core.c:6890 preempt_schedule_thunk+0x1a/0x30 arch/x86/entry/thunk_64.S:45 __raw_spin_unlock include/linux/spinlock_api_smp.h:143 [inline] _raw_spin_unlock+0x3a/0x40 kernel/locking/spinlock.c:186 spin_unlock include/linux/spinlock.h:391 [inline] nilfs_load_inode_block+0x271/0x340 fs/nilfs2/inode.c:1066 __nilfs_mark_inode_dirty+0x10c/0x2b0 fs/nilfs2/inode.c:1136 nilfs_dirty_inode+0x164/0x200 fs/nilfs2/inode.c:1177 __mark_inode_dirty+0x2cc/0xca0 fs/fs-writeback.c:2465 generic_update_time fs/inode.c:1981 [inline] inode_update_time fs/inode.c:1994 [inline] __file_update_time fs/inode.c:2180 [inline] file_update_time+0x197/0x1b0 fs/inode.c:2210 __generic_file_write_iter+0x9a/0x230 mm/filemap.c:4107 generic_file_write_iter+0xaf/0x2e0 mm/filemap.c:4152 call_write_iter include/linux/fs.h:2018 [inline] new_sync_write fs/read_write.c:491 [inline] vfs_write+0x43b/0x940 fs/read_write.c:584 ksys_write+0x147/0x250 fs/read_write.c:637 do_syscall_x64 arch/x86/entry/common.c:51 [inline] do_syscall_64+0x55/0xb0 arch/x86/entry/common.c:81 entry_SYSCALL_64_after_hwframe+0x68/0xd2 RIP: 0033:0x7f0f3d98f749 Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48 RSP: 002b:00007f0f3e8c9038 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007f0f3dbe6090 RCX: 00007f0f3d98f749 RDX: 000000000208e24b RSI: 0000200000000040 RDI: 0000000000000007 RBP: 00007f0f3e8c9090 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000001 R13: 00007f0f3dbe6128 R14: 00007f0f3dbe6090 R15: 00007ffdb719e268