QAT: Invalid ioctl loop: Write error at byte offset 18446744073709551613, length 2048. ====================================================== WARNING: possible circular locking dependency detected 4.13.0+ #70 Not tainted ------------------------------------------------------ loop0/3555 is trying to acquire lock: (sb_writers#5){.+.+}, at: [] file_start_write include/linux/fs.h:2661 [inline] (sb_writers#5){.+.+}, at: [] lo_write_bvec+0x23a/0x3b0 drivers/block/loop.c:268 but now in release context of a crosslock acquired at the following: ((complete)&ret.event){+.+.}, at: [] submit_bio_wait+0x15e/0x200 block/bio.c:949 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #5 ((complete)&ret.event){+.+.}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x328f/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 complete_acquire include/linux/completion.h:39 [inline] __wait_for_common kernel/sched/completion.c:108 [inline] wait_for_common_io kernel/sched/completion.c:128 [inline] wait_for_completion_io+0xc8/0x770 kernel/sched/completion.c:176 submit_bio_wait+0x15e/0x200 block/bio.c:949 blkdev_issue_zeroout+0x13c/0x1d0 block/blk-lib.c:370 sb_issue_zeroout include/linux/blkdev.h:1369 [inline] ext4_init_inode_table+0x4fd/0xdb1 fs/ext4/ialloc.c:1420 ext4_run_li_request fs/ext4/super.c:2845 [inline] ext4_lazyinit_thread+0x81a/0xd40 fs/ext4/super.c:2939 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 -> #4 (&meta_group_info[i]->alloc_sem){++++}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x328f/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 down_read+0x96/0x150 kernel/locking/rwsem.c:23 __ext4_new_inode+0x27fc/0x5200 fs/ext4/ialloc.c:1029 ext4_symlink+0x2d9/0xae0 fs/ext4/namei.c:3118 vfs_symlink+0x323/0x560 fs/namei.c:4107 SYSC_symlinkat fs/namei.c:4134 [inline] SyS_symlinkat fs/namei.c:4114 [inline] SYSC_symlink fs/namei.c:4147 [inline] SyS_symlink+0x134/0x200 fs/namei.c:4145 entry_SYSCALL_64_fastpath+0x1f/0xbe -> #3 (jbd2_handle){++++}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x328f/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 start_this_handle+0x4b8/0x1080 fs/jbd2/transaction.c:390 jbd2__journal_start+0x389/0x9f0 fs/jbd2/transaction.c:444 __ext4_journal_start_sb+0x15f/0x550 fs/ext4/ext4_jbd2.c:80 __ext4_journal_start fs/ext4/ext4_jbd2.h:314 [inline] ext4_dirty_inode+0x56/0xa0 fs/ext4/inode.c:5879 __mark_inode_dirty+0x912/0x1170 fs/fs-writeback.c:2096 generic_update_time+0x1b2/0x270 fs/inode.c:1635 update_time fs/inode.c:1651 [inline] touch_atime+0x26d/0x2f0 fs/inode.c:1723 file_accessed include/linux/fs.h:2038 [inline] ext4_file_mmap+0x161/0x1b0 fs/ext4/file.c:367 call_mmap include/linux/fs.h:1750 [inline] mmap_region+0xa99/0x15a0 mm/mmap.c:1689 do_mmap+0x6a1/0xd50 mm/mmap.c:1467 do_mmap_pgoff include/linux/mm.h:2108 [inline] vm_mmap_pgoff+0x1de/0x280 mm/util.c:333 SYSC_mmap_pgoff mm/mmap.c:1517 [inline] SyS_mmap_pgoff+0x462/0x5f0 mm/mmap.c:1475 SYSC_mmap arch/x86/kernel/sys_x86_64.c:99 [inline] SyS_mmap+0x16/0x20 arch/x86/kernel/sys_x86_64.c:90 entry_SYSCALL_64_fastpath+0x1f/0xbe -> #2 (&mm->mmap_sem){++++}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x328f/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 __might_fault+0x13a/0x1d0 mm/memory.c:4337 _copy_to_user+0x2c/0xc0 lib/usercopy.c:24 copy_to_user include/linux/uaccess.h:154 [inline] filldir+0x1a7/0x320 fs/readdir.c:196 dir_emit_dot include/linux/fs.h:3300 [inline] dir_emit_dots include/linux/fs.h:3311 [inline] dcache_readdir+0x12d/0x5e0 fs/libfs.c:192 iterate_dir+0x4b2/0x5d0 fs/readdir.c:51 SYSC_getdents fs/readdir.c:231 [inline] SyS_getdents+0x225/0x450 fs/readdir.c:212 entry_SYSCALL_64_fastpath+0x1f/0xbe -> #1 (&sb->s_type->i_mutex_key#9){++++}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x328f/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 down_write+0x87/0x120 kernel/locking/rwsem.c:53 inode_lock include/linux/fs.h:711 [inline] do_last fs/namei.c:3288 [inline] path_openat+0xd53/0x3520 fs/namei.c:3519 do_filp_open+0x25b/0x3b0 fs/namei.c:3554 do_sys_open+0x502/0x6d0 fs/open.c:1059 SYSC_open fs/open.c:1077 [inline] SyS_open+0x2d/0x40 fs/open.c:1072 entry_SYSCALL_64_fastpath+0x1f/0xbe -> #0 (sb_writers#5){.+.+}: percpu_down_read_preempt_disable include/linux/percpu-rwsem.h:35 [inline] percpu_down_read include/linux/percpu-rwsem.h:58 [inline] __sb_start_write+0x18f/0x290 fs/super.c:1340 file_start_write include/linux/fs.h:2661 [inline] lo_write_bvec+0x23a/0x3b0 drivers/block/loop.c:268 lo_write_transfer drivers/block/loop.c:326 [inline] do_req_filebacked drivers/block/loop.c:530 [inline] loop_handle_cmd drivers/block/loop.c:1694 [inline] loop_queue_work+0x109d/0x3900 drivers/block/loop.c:1708 kthread_worker_fn+0x340/0x9b0 kernel/kthread.c:635 loop_kthread_worker_fn+0x51/0x60 drivers/block/loop.c:850 other info that might help us debug this: Chain exists of: sb_writers#5 --> &meta_group_info[i]->alloc_sem --> (complete)&ret.event Possible unsafe locking scenario by crosslock: CPU0 CPU1 ---- ---- lock(&meta_group_info[i]->alloc_sem); lock((complete)&ret.event); lock(sb_writers#5); unlock((complete)&ret.event); *** DEADLOCK *** 1 lock held by loop0/3555: #0: (&x->wait#14){..-.}, at: [] complete+0x18/0x80 kernel/sched/completion.c:34 stack backtrace: CPU: 0 PID: 3555 Comm: loop0 Not tainted 4.13.0+ #70 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:16 [inline] dump_stack+0x194/0x257 lib/dump_stack.c:52 print_circular_bug+0x503/0x710 kernel/locking/lockdep.c:1259 check_prev_add+0x865/0x1520 kernel/locking/lockdep.c:1894 commit_xhlock kernel/locking/lockdep.c:5015 [inline] commit_xhlocks kernel/locking/lockdep.c:5059 [inline] lock_commit_crosslock+0xe73/0x1d10 kernel/locking/lockdep.c:5098 complete_release_commit include/linux/completion.h:49 [inline] complete+0x24/0x80 kernel/sched/completion.c:39 submit_bio_wait_endio+0x96/0xc0 block/bio.c:930 bio_endio+0x2ec/0x900 block/bio.c:1839 req_bio_endio block/blk-core.c:204 [inline] blk_update_request+0x2a0/0xe10 block/blk-core.c:2729 blk_mq_end_request+0x54/0x120 block/blk-mq.c:474 lo_complete_rq+0xbe/0x1f0 drivers/block/loop.c:460 __blk_mq_complete_request+0x396/0x6c0 block/blk-mq.c:515 blk_mq_complete_request+0x4f/0x60 block/blk-mq.c:535 loop_handle_cmd drivers/block/loop.c:1699 [inline] loop_queue_work+0x26b/0x3900 drivers/block/loop.c:1708 kthread_worker_fn+0x340/0x9b0 kernel/kthread.c:635 loop_kthread_worker_fn+0x51/0x60 drivers/block/loop.c:850 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 sctp: [Deprecated]: syz-executor0 (pid 10344) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor0 (pid 10344) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=10364 comm=syz-executor3 sctp: [Deprecated]: syz-executor4 (pid 10371) Use of int in maxseg socket option. Use struct sctp_assoc_value instead SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=10364 comm=syz-executor3 RDS: rds_bind could not find a transport for 172.20.3.187, load rds_tcp or rds_rdma? RDS: rds_bind could not find a transport for 172.20.3.187, load rds_tcp or rds_rdma? SELinux: unrecognized netlink message: protocol=0 nlmsg_type=22549 sclass=netlink_route_socket pig=10575 comm=syz-executor5 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=22549 sclass=netlink_route_socket pig=10588 comm=syz-executor5 SELinux: unrecognized netlink message: protocol=9 nlmsg_type=17 sclass=netlink_audit_socket pig=10589 comm=syz-executor1 sctp: [Deprecated]: syz-executor1 (pid 10618) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor1 (pid 10618) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead TCP: request_sock_TCPv6: Possible SYN flooding on port 20017. Sending cookies. Check SNMP counters. netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. print_req_error: 367 callbacks suppressed print_req_error: I/O error, dev loop0, sector 0 print_req_error: I/O error, dev loop0, sector 0 buffer_io_error: 358 callbacks suppressed Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read Buffer I/O error on dev loop0, logical block 0, async page read device lo entered promiscuous mode TCP: request_sock_TCPv6: Possible SYN flooding on port 20013. Sending cookies. Check SNMP counters. device gre0 entered promiscuous mode QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl skbuff: bad partial csum: csum=49149/21163 len=4778 netlink: 5 bytes leftover after parsing attributes in process `syz-executor5'. skbuff: bad partial csum: csum=49149/21163 len=4778 netlink: 5 bytes leftover after parsing attributes in process `syz-executor5'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. QAT: Invalid ioctl QAT: Invalid ioctl netlink: 5 bytes leftover after parsing attributes in process `syz-executor7'. SELinux: unrecognized netlink message: protocol=0 nlmsg_type=3 sclass=netlink_route_socket pig=11002 comm=syz-executor1 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11002 comm=syz-executor1 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=51 sclass=netlink_route_socket pig=11002 comm=syz-executor1 sock: process `syz-executor1' is using obsolete setsockopt SO_BSDCOMPAT SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11010 comm=syz-executor1 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=35125 sclass=netlink_route_socket pig=11009 comm=syz-executor4 netlink: 13 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl device syz2 entered promiscuous mode device syz2 left promiscuous mode device syz2 entered promiscuous mode device lo left promiscuous mode dccp_v4_rcv: dropped packet with invalid checksum dccp_v4_rcv: dropped packet with invalid checksum device lo left promiscuous mode xprt_adjust_timeout: rq_timeout = 0! xprt_adjust_timeout: rq_timeout = 0! rpcbind: RPC call returned error 22 rpcbind: RPC call returned error 22 QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl SELinux: failure in selinux_parse_skb(), unable to parse packet nla_parse: 11 callbacks suppressed netlink: 11 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 11 bytes leftover after parsing attributes in process `syz-executor7'. device gre0 entered promiscuous mode QAT: Invalid ioctl QAT: Invalid ioctl print_req_error: 163 callbacks suppressed print_req_error: I/O error, dev loop0, sector 0 QAT: Invalid ioctl print_req_error: I/O error, dev loop0, sector 0 QAT: Invalid ioctl buffer_io_error: 158 callbacks suppressed Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read Buffer I/O error on dev loop0, logical block 0, async page read QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl FAULT_INJECTION: forcing a failure. name failslab, interval 1, probability 0, space 0, times 1 CPU: 0 PID: 12352 Comm: syz-executor3 Not tainted 4.13.0+ #70 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:16 [inline] dump_stack+0x194/0x257 lib/dump_stack.c:52 fail_dump lib/fault-inject.c:51 [inline] should_fail+0x8c0/0xa40 lib/fault-inject.c:149 should_failslab+0xec/0x120 mm/failslab.c:31 slab_pre_alloc_hook mm/slab.h:422 [inline] slab_alloc_node mm/slab.c:3304 [inline] kmem_cache_alloc_node+0x56/0x760 mm/slab.c:3649 __alloc_skb+0xf1/0x740 net/core/skbuff.c:219 alloc_skb_fclone include/linux/skbuff.h:945 [inline] tcp_send_fin+0x25d/0xd50 net/ipv4/tcp_output.c:3047 tcp_shutdown+0xe1/0x110 net/ipv4/tcp.c:2090 inet_shutdown+0x170/0x350 net/ipv4/af_inet.c:832 SYSC_shutdown net/socket.c:1890 [inline] SyS_shutdown+0x137/0x290 net/socket.c:1881 entry_SYSCALL_64_fastpath+0x1f/0xbe RIP: 0033:0x451e59 RSP: 002b:00007f7985989c08 EFLAGS: 00000216 ORIG_RAX: 0000000000000030 RAX: ffffffffffffffda RBX: 00000000007180b0 RCX: 0000000000451e59 RDX: 0000000000000000 RSI: 2020000000000001 RDI: 0000000000000005 RBP: 00007f7985989a10 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000216 R12: 00000000004b69f7 R13: 00007f7985989b48 R14: 00000000004b6a07 R15: 0000000000000000 QAT: Invalid ioctl