INFO: task hung in nilfs_segctor_thread

17 views
Skip to first unread message

syzbot

unread,
Nov 4, 2022, 11:06:46 PM11/4/22
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: 3f8a27f9e27b Linux 4.19.211
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=1367ae41880000
kernel config: https://syzkaller.appspot.com/x/.config?x=9b9277b418617afe
dashboard link: https://syzkaller.appspot.com/bug?extid=e07ad170cd11d4d7ef81
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)

Unfortunately, I don't have any reproducer for this issue yet.

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/98c0bdb4abb3/disk-3f8a27f9.raw.xz
vmlinux: https://storage.googleapis.com/syzbot-assets/ea228ff02669/vmlinux-3f8a27f9.xz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+e07ad1...@syzkaller.appspotmail.com

IPVS: ftp: loaded support on port[0] = 21
IPVS: ftp: loaded support on port[0] = 21
INFO: task segctord:22771 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
segctord D30088 22771 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
__rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:589 [inline]
rwsem_down_write_failed+0x3aa/0x760 kernel/locking/rwsem-xadd.c:618
call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:117
__down_write arch/x86/include/asm/rwsem.h:142 [inline]
down_write+0x4f/0x90 kernel/locking/rwsem.c:72
nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362
nilfs_segctor_thread_construct fs/nilfs2/segment.c:2479 [inline]
nilfs_segctor_thread+0x3c0/0xf50 fs/nilfs2/segment.c:2563
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task segctord:22829 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
segctord D30320 22829 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
__rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:589 [inline]
rwsem_down_write_failed+0x3aa/0x760 kernel/locking/rwsem-xadd.c:618
call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:117
__down_write arch/x86/include/asm/rwsem.h:142 [inline]
down_write+0x4f/0x90 kernel/locking/rwsem.c:72
nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362
nilfs_segctor_thread_construct fs/nilfs2/segment.c:2479 [inline]
nilfs_segctor_thread+0x3c0/0xf50 fs/nilfs2/segment.c:2563
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415

Showing all locks held in the system:
1 lock held by khungtaskd/1570:
#0: 00000000d4bd1c35 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
1 lock held by in:imklog/7887:
#0: 000000000329f440 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
2 locks held by agetty/8043:
#0: 000000005e8776b8 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272
#1: 00000000948f93ea (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1950 drivers/tty/n_tty.c:2154
6 locks held by syz-executor.4/22761:
1 lock held by segctord/22771:
#0: 000000006d633e6d (&nilfs->ns_segctor_sem){++++}, at: nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362
5 locks held by syz-executor.3/22821:
1 lock held by segctord/22829:
#0: 0000000059cb8935 (&nilfs->ns_segctor_sem){++++}, at: nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362
3 locks held by kworker/u4:10/27812:
2 locks held by syz-executor.1/8563:
3 locks held by syz-executor.0/8564:
#0: 00000000d90ff802 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1826 [inline]
#0: 00000000d90ff802 (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455
IPVS: ftp: loaded support on port[0] = 21
#1: 00000000d4bd1c35 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline]
#1: 00000000d4bd1c35 (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857
#2: 000000002b0edb20 (&sig->wait_chldexit){....}, at: __wake_up_common_lock+0xb0/0x170 kernel/sched/wait.c:120
IPVS: ftp: loaded support on port[0] = 21
2 locks held by syz-executor.4/8568:
#0: 0000000031378ec2 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x1d8/0x340 net/core/net_namespace.c:435
#1: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: gtp_net_exit+0x1ba/0x380 drivers/net/gtp.c:1360
2 locks held by syz-executor.4/8576:
#0: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: rtnl_lock net/core/rtnetlink.c:77 [inline]
#0: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: rtnetlink_rcv_msg+0x3fe/0xb80 net/core/rtnetlink.c:4779
#1: 000000008fac0dd7 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:329 [inline]
#1: 000000008fac0dd7 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x256/0x6f0 kernel/rcu/tree_exp.h:667
2 locks held by syz-executor.4/8582:
#0: 0000000031378ec2 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x1d8/0x340 net/core/net_namespace.c:435
#1: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: gtp_net_exit+0x1ba/0x380 drivers/net/gtp.c:1360
2 locks held by syz-executor.3/8567:
#0: 00000000a2dda670 (&sb->s_type->i_mutex_key#13){+.+.}, at: inode_lock include/linux/fs.h:748 [inline]
#0: 00000000a2dda670 (&sb->s_type->i_mutex_key#13){+.+.}, at: __sock_release+0x86/0x2a0 net/socket.c:598
#1: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: ip6mr_sk_done+0xe0/0x370 net/ipv6/ip6mr.c:1564
3 locks held by syz-executor.1/8600:
#0: 00000000fde6b05b (cb_lock){++++}, at: genl_rcv+0x15/0x40 net/netlink/genetlink.c:637
#1: 0000000023c96437 (genl_mutex){+.+.}, at: genl_lock net/netlink/genetlink.c:33 [inline]
#1: 0000000023c96437 (genl_mutex){+.+.}, at: genl_rcv_msg+0x12f/0x160 net/netlink/genetlink.c:625
#2: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: tipc_nl_bearer_enable+0x13/0x30 net/tipc/bearer.c:924
1 lock held by syz-executor.2/8606:
#0: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: rtnl_lock net/core/rtnetlink.c:77 [inline]
#0: 0000000044acd3c3 (rtnl_mutex){+.+.}, at: rtnetlink_rcv_msg+0x3fe/0xb80 net/core/rtnetlink.c:4779
3 locks held by syz-executor.0/8610:

FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1)
=============================================

Enabling of bearer <udp:syz2> rejected, failed to enable media
NMI backtrace for cpu 1
CPU: 1 PID: 1570 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x1fc/0x2ef lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
watchdog+0x991/0xe60 kernel/hung_task.c:287
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4698 Comm: systemd-udevd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022
RIP: 0010:__list_del_entry_valid+0xb3/0xf0 lib/list_debug.c:54
Code: 14 24 48 39 ea 0f 85 e8 51 85 04 49 8d 7d 08 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 80 3c 02 00 75 22 49 8b 55 08 <48> 39 ea 0f 85 f9 51 85 04 5d b8 01 00 00 00 41 5c 41 5d c3 e8 44
RSP: 0018:ffff88809b9df7d0 EFLAGS: 00000046
RAX: dffffc0000000000 RBX: 0000000000000001 RCX: 0000000000000000
RDX: ffffea0002cb5708 RSI: 0000000000000068 RDI: ffffea00011c6110
RBP: ffffea0002cb5708 R08: 0000000000000001 R09: ffffed1027fff788
R10: ffff88813fffbc43 R11: 0000000000000000 R12: ffff88813fffb828
R13: ffffea00011c6108 R14: ffff88813fffb6c0 R15: dffffc0000000000
FS: 00007f90780e98c0(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fc53f92caa5 CR3: 000000009ba3a000 CR4: 00000000003406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
__list_del_entry include/linux/list.h:117 [inline]
list_del include/linux/list.h:125 [inline]
__rmqueue_smallest mm/page_alloc.c:1985 [inline]
__rmqueue mm/page_alloc.c:2475 [inline]
rmqueue mm/page_alloc.c:3034 [inline]
get_page_from_freelist+0x180f/0x4170 mm/page_alloc.c:3373
__alloc_pages_nodemask+0x387/0x2890 mm/page_alloc.c:4399
__alloc_pages include/linux/gfp.h:496 [inline]
__alloc_pages_node include/linux/gfp.h:509 [inline]
kmem_getpages mm/slab.c:1412 [inline]
cache_grow_begin+0xa4/0x8a0 mm/slab.c:2682
cache_alloc_refill+0x273/0x340 mm/slab.c:3049
____cache_alloc mm/slab.c:3132 [inline]
__do_cache_alloc mm/slab.c:3354 [inline]
slab_alloc mm/slab.c:3389 [inline]
kmem_cache_alloc+0x346/0x370 mm/slab.c:3557
getname_flags+0xce/0x590 fs/namei.c:140
user_path_at_empty+0x2a/0x50 fs/namei.c:2609
user_path_at include/linux/namei.h:57 [inline]
vfs_statx+0x113/0x210 fs/stat.c:185
vfs_lstat include/linux/fs.h:3137 [inline]
__do_sys_newlstat fs/stat.c:350 [inline]
__se_sys_newlstat+0x96/0x120 fs/stat.c:344
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f9076f5b335
Code: 69 db 2b 00 64 c7 00 16 00 00 00 b8 ff ff ff ff c3 0f 1f 40 00 83 ff 01 48 89 f0 77 30 48 89 c7 48 89 d6 b8 06 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 03 f3 c3 90 48 8b 15 31 db 2b 00 f7 d8 64 89
RSP: 002b:00007ffcda27c068 EFLAGS: 00000246 ORIG_RAX: 0000000000000006
RAX: ffffffffffffffda RBX: 00005625e655c7d0 RCX: 00007f9076f5b335
RDX: 00007ffcda27c0a0 RSI: 00007ffcda27c0a0 RDI: 00005625e655b7d0
RBP: 00007ffcda27c160 R08: 00007f907721a1f8 R09: 0000000000001010
R10: 00007f9077219b58 R11: 0000000000000246 R12: 00005625e655b7d0
R13: 00005625e655b7f0 R14: 00005625e654869b R15: 00005625e65486a0


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

syzbot

unread,
Feb 14, 2023, 10:00:44 AM2/14/23
to syzkaller...@googlegroups.com
syzbot has found a reproducer for the following issue on:

HEAD commit: 3f8a27f9e27b Linux 4.19.211
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=127f1d10c80000
kernel config: https://syzkaller.appspot.com/x/.config?x=9b9277b418617afe
dashboard link: https://syzkaller.appspot.com/bug?extid=e07ad170cd11d4d7ef81
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=15495f00c80000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=124f15d0c80000
mounted in repro: https://storage.googleapis.com/syzbot-assets/f7391dce4f55/mount_0.gz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+e07ad1...@syzkaller.appspotmail.com

NILFS (loop0): unable to move secondary superblock to block 18446744073709551612
audit: type=1804 audit(1676386495.968:3): pid=8112 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor304" name="/root/file0/bus" dev="loop0" ino=12 res=1
INFO: task segctord:8118 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
segctord D26288 8118 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
__rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:589 [inline]
rwsem_down_write_failed+0x3aa/0x760 kernel/locking/rwsem-xadd.c:618
call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:117
__down_write arch/x86/include/asm/rwsem.h:142 [inline]
down_write+0x4f/0x90 kernel/locking/rwsem.c:72
nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362
nilfs_segctor_thread_construct fs/nilfs2/segment.c:2479 [inline]
nilfs_segctor_thread+0x3c0/0xf50 fs/nilfs2/segment.c:2563
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415

Showing all locks held in the system:
1 lock held by khungtaskd/1571:
#0: 000000005bc60963 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
1 lock held by kswapd0/1969:
1 lock held by in:imklog/7781:
#0: 00000000d60cbbee (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
4 locks held by syz-executor304/8112:
1 lock held by segctord/8118:
#0: 0000000090ee38e8 (&nilfs->ns_segctor_sem){++++}, at: nilfs_transaction_lock+0x1fb/0x8b0 fs/nilfs2/segment.c:362

=============================================

NMI backtrace for cpu 0
CPU: 0 PID: 1571 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x1fc/0x2ef lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
watchdog+0x991/0xe60 kernel/hung_task.c:287
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 8112 Comm: syz-executor304 Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023
RIP: 0010:arch_local_save_flags arch/x86/include/asm/paravirt.h:784 [inline]
RIP: 0010:arch_local_irq_save arch/x86/include/asm/paravirt.h:806 [inline]
RIP: 0010:lock_is_held_type+0x82/0x210 kernel/locking/lockdep.c:3942
Code: f1 89 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 0f 85 6a 01 00 00 48 83 3d 36 cd a6 08 00 0f 84 1d 01 00 00 9c 58 <0f> 1f 44 00 00 48 ba 00 00 00 00 00 fc ff df 48 89 c3 48 c7 c0 90
RSP: 0018:ffff8880956bf550 EFLAGS: 00000286
RAX: 0000000000000286 RBX: ffff8880b512e200 RCX: 0000000000000001
RDX: dffffc0000000000 RSI: 00000000ffffffff RDI: ffff8880b512ea84
RBP: ffffffff89f85f60 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000005 R11: 00000000135a7410 R12: 00000000000001e2
R13: dffffc0000000000 R14: ffff88808e55dc08 R15: ffffea0000428448
FS: 000055555648f300(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00005652cee9ce50 CR3: 00000000a51da000 CR4: 00000000003406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_is_held include/linux/lockdep.h:344 [inline]
___might_sleep+0x1ea/0x2b0 kernel/sched/core.c:6157
lock_page include/linux/pagemap.h:482 [inline]
pagecache_get_page+0x5f2/0xd50 mm/filemap.c:1577
find_or_create_page include/linux/pagemap.h:322 [inline]
grab_cache_page include/linux/pagemap.h:388 [inline]
nilfs_grab_buffer+0xa5/0x560 fs/nilfs2/page.c:57
nilfs_mdt_submit_block.constprop.0+0xa8/0xaa0 fs/nilfs2/mdt.c:121
nilfs_mdt_read_block+0x96/0x3e0 fs/nilfs2/mdt.c:175
nilfs_mdt_get_block+0xe6/0xd40 fs/nilfs2/mdt.c:250
nilfs_sufile_get_segment_usage_block fs/nilfs2/sufile.c:92 [inline]
nilfs_sufile_truncate_range fs/nilfs2/sufile.c:674 [inline]
nilfs_sufile_resize+0x760/0x1230 fs/nilfs2/sufile.c:772
nilfs_resize_fs+0x1e4/0xdb0 fs/nilfs2/super.c:423
nilfs_ioctl_resize fs/nilfs2/ioctl.c:1054 [inline]
nilfs_ioctl+0x1138/0x1bf0 fs/nilfs2/ioctl.c:1326
vfs_ioctl fs/ioctl.c:46 [inline]
file_ioctl fs/ioctl.c:501 [inline]
do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688
ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705
__do_sys_ioctl fs/ioctl.c:712 [inline]
__se_sys_ioctl fs/ioctl.c:710 [inline]
__x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7ff704870619
Code: Bad RIP value.
RSP: 002b:00007ffd19320f88 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007ff704870619
RDX: 0000000020000040 RSI: 0000000040086e8b RDI: 0000000000000006
RBP: 0000000000000000 R08: 00007ff7048deec0 R09: 00007ff7048deec0
R10: 00007ff7048deec0 R11: 0000000000000246 R12: 00007ffd19320fb0
R13: 0000000000000000 R14: 431bde82d7b634db R15: 0000000000000000

syzbot

unread,
Feb 16, 2023, 2:03:45 AM2/16/23
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: a8ad60f2af58 Linux 4.14.305
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=167122e7480000
kernel config: https://syzkaller.appspot.com/x/.config?x=2f23dc9802022031
dashboard link: https://syzkaller.appspot.com/bug?extid=4fe7dca454f0d535125b
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=1372ecd7480000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=10641e20c80000

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/c38348fd389d/disk-a8ad60f2.raw.xz
vmlinux: https://storage.googleapis.com/syzbot-assets/3a775d221689/vmlinux-a8ad60f2.xz
kernel image: https://storage.googleapis.com/syzbot-assets/32e71e04d2b4/bzImage-a8ad60f2.xz
mounted in repro: https://storage.googleapis.com/syzbot-assets/d920e7792bc4/mount_0.gz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+4fe7dc...@syzkaller.appspotmail.com

NILFS (loop0): unable to move secondary superblock to block 18446744073709551612
audit: type=1804 audit(1676530624.284:3): pid=7977 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor157" name="/root/file0/bus" dev="loop0" ino=12 res=1
INFO: task segctord:7982 blocked for more than 140 seconds.
Not tainted 4.14.305-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
segctord D27400 7982 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2811 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3386
schedule+0x8d/0x1b0 kernel/sched/core.c:3430
__rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:588 [inline]
rwsem_down_write_failed+0x343/0x6d0 kernel/locking/rwsem-xadd.c:617
call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:105
__down_write arch/x86/include/asm/rwsem.h:126 [inline]
down_write+0x4f/0x90 kernel/locking/rwsem.c:56
nilfs_transaction_lock+0x1f9/0x860 fs/nilfs2/segment.c:371
nilfs_segctor_thread_construct fs/nilfs2/segment.c:2501 [inline]
nilfs_segctor_thread+0x3a2/0xdb0 fs/nilfs2/segment.c:2586
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:406

Showing all locks held in the system:
1 lock held by khungtaskd/1534:
#0: (tasklist_lock){.+.+}, at: [<ffffffff8702d99c>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548
1 lock held by segctord/7982:
#0: (&nilfs->ns_segctor_sem){++++}, at: [<ffffffff826ff8f9>] nilfs_transaction_lock+0x1f9/0x860 fs/nilfs2/segment.c:371

=============================================

NMI backtrace for cpu 0
CPU: 0 PID: 1534 Comm: khungtaskd Not tainted 4.14.305-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023
Call Trace:
__dump_stack lib/dump_stack.c:17 [inline]
dump_stack+0x1b2/0x281 lib/dump_stack.c:58
nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
watchdog+0x5b9/0xb40 kernel/hung_task.c:274
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:406
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 7977 Comm: syz-executor157 Not tainted 4.14.305-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023
task: ffff8880b565c540 task.stack: ffff8880b3040000
RIP: 0010:arch_local_save_flags arch/x86/include/asm/paravirt.h:774 [inline]
RIP: 0010:arch_local_irq_save arch/x86/include/asm/paravirt.h:796 [inline]
RIP: 0010:lock_release+0xc2/0x870 kernel/locking/lockdep.c:4013
RSP: 0018:ffff8880b30470f0 EFLAGS: 00000086
RAX: 0000000000000086 RBX: 1ffff11016608e21 RCX: 0000000000007feb
RDX: dffffc0000000000 RSI: 0000000000000001 RDI: ffff8880b565cdc4
RBP: ffff88813fffb758 R08: ffffffff8b9e5ad8 R09: 00000000000e001f
R10: 0000000000000000 R11: ffff8880b565c540 R12: ffffffff816a3f10
R13: ffff8880b565c540 R14: 1ffffffff11e13da R15: 0000000000000086
FS: 0000555555cd0300(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f6594058160 CR3: 00000000af5fb000 CR4: 00000000003406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
seqcount_lockdep_reader_access include/linux/seqlock.h:82 [inline]
read_seqcount_begin include/linux/seqlock.h:164 [inline]
read_seqbegin include/linux/seqlock.h:441 [inline]
zone_span_seqbegin include/linux/memory_hotplug.h:80 [inline]
page_outside_zone_boundaries+0xcf/0x310 mm/page_alloc.c:496
bad_range mm/page_alloc.c:525 [inline]
__free_one_page mm/page_alloc.c:828 [inline]
free_pcppages_bulk+0x2e0/0x1460 mm/page_alloc.c:1162
free_hot_cold_page+0x90e/0xca0 mm/page_alloc.c:2646
slab_destroy mm/slab.c:1723 [inline]
slabs_destroy+0x90/0xd0 mm/slab.c:1739
cache_flusharray mm/slab.c:3483 [inline]
___cache_free+0x213/0x2c0 mm/slab.c:3525
qlink_free mm/kasan/quarantine.c:147 [inline]
qlist_free_all+0x79/0x140 mm/kasan/quarantine.c:166
quarantine_reduce+0x185/0x200 mm/kasan/quarantine.c:259
kasan_kmalloc+0xa2/0x160 mm/kasan/kasan.c:536
slab_post_alloc_hook mm/slab.h:442 [inline]
slab_alloc mm/slab.c:3390 [inline]
kmem_cache_alloc+0x111/0x3c0 mm/slab.c:3550
kmem_cache_zalloc include/linux/slab.h:651 [inline]
alloc_buffer_head+0x20/0x110 fs/buffer.c:3429
alloc_page_buffers+0xb3/0x1f0 fs/buffer.c:874
create_empty_buffers+0x2c/0x470 fs/buffer.c:1590
__nilfs_get_page_block fs/nilfs2/page.c:46 [inline]
nilfs_grab_buffer+0x1fb/0x420 fs/nilfs2/page.c:70
nilfs_mdt_submit_block.constprop.0+0x8e/0x970 fs/nilfs2/mdt.c:130
nilfs_mdt_read_block+0x7c/0x320 fs/nilfs2/mdt.c:184
nilfs_mdt_get_block+0xc7/0xb90 fs/nilfs2/mdt.c:259
nilfs_sufile_get_segment_usage_block fs/nilfs2/sufile.c:101 [inline]
nilfs_sufile_truncate_range fs/nilfs2/sufile.c:691 [inline]
nilfs_sufile_resize+0x6b7/0x1060 fs/nilfs2/sufile.c:789
nilfs_resize_fs+0x1c3/0xd20 fs/nilfs2/super.c:434
nilfs_ioctl_resize fs/nilfs2/ioctl.c:1063 [inline]
nilfs_ioctl+0x123e/0x1930 fs/nilfs2/ioctl.c:1335
vfs_ioctl fs/ioctl.c:46 [inline]
file_ioctl fs/ioctl.c:500 [inline]
do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684
SYSC_ioctl fs/ioctl.c:701 [inline]
SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692
do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x5e/0xd3
RIP: 0033:0x7fa0d3c07619
RSP: 002b:00007ffdb60d1908 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fa0d3c07619
RDX: 0000000020000040 RSI: 0000000040086e8b RDI: 0000000000000006
RBP: 0000000000000000 R08: 00007fa0d3c75ec0 R09: 00007fa0d3c75ec0
R10: 00007fa0d3c75ec0 R11: 0000000000000246 R12: 00007ffdb60d1930
R13: 0000000000000000 R14: 431bde82d7b634db R15: 0000000000000000
Code: 9e f0 88 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 0f 85 98 06 00 00 48 83 3d 26 be ae 07 00 0f 84 0e 05 00 00 9c 58 <0f> 1f 44 00 00 48 ba 00 00 00 00 00 fc ff df 48 89 04 24 48 c7


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.
syzbot can test patches for this issue, for details see:
https://goo.gl/tpsmEJ#testing-patches
Reply all
Reply to author
Forward
0 new messages