loop: Write error at byte offset 18446744073709551614, length 4096. ====================================================== WARNING: possible circular locking dependency detected 4.14.0-rc4+ #128 Not tainted ------------------------------------------------------ loop0/7691 is trying to acquire lock: (sb_writers#5){.+.+}, at: [] file_start_write include/linux/fs.h:2696 [inline] (sb_writers#5){.+.+}, at: [] lo_write_bvec+0x23a/0x3b0 drivers/block/loop.c:271 but now in release context of a crosslock acquired at the following: ((complete)&ret.event){+.+.}, at: [] submit_bio_wait+0x15e/0x200 block/bio.c:953 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+0xcb/0x7b0 kernel/sched/completion.c:176 submit_bio_wait+0x15e/0x200 block/bio.c:953 blkdev_issue_zeroout+0x13c/0x1d0 block/blk-lib.c:370 sb_issue_zeroout include/linux/blkdev.h:1368 [inline] ext4_init_inode_table+0x4fd/0xdb1 fs/ext4/ialloc.c:1447 ext4_run_li_request fs/ext4/super.c:2866 [inline] ext4_lazyinit_thread+0x808/0xd30 fs/ext4/super.c:2960 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+0x26dc/0x4f00 fs/ext4/ialloc.c:1056 ext4_symlink+0x2d9/0xae0 fs/ext4/namei.c:3118 vfs_symlink+0x323/0x560 fs/namei.c:4115 SYSC_symlinkat fs/namei.c:4142 [inline] SyS_symlinkat fs/namei.c:4122 [inline] SYSC_symlink fs/namei.c:4155 [inline] SyS_symlink+0x134/0x200 fs/namei.c:4153 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:5859 __mark_inode_dirty+0x912/0x1170 fs/fs-writeback.c:2096 generic_update_time+0x1b2/0x270 fs/inode.c:1649 update_time fs/inode.c:1665 [inline] touch_atime+0x26d/0x2f0 fs/inode.c:1737 file_accessed include/linux/fs.h:2061 [inline] ext4_file_mmap+0x161/0x1b0 fs/ext4/file.c:352 call_mmap include/linux/fs.h:1775 [inline] mmap_region+0xa99/0x15a0 mm/mmap.c:1690 do_mmap+0x6a1/0xd50 mm/mmap.c:1468 do_mmap_pgoff include/linux/mm.h:2150 [inline] vm_mmap_pgoff+0x1de/0x280 mm/util.c:333 SYSC_mmap_pgoff mm/mmap.c:1518 [inline] SyS_mmap_pgoff+0x462/0x5f0 mm/mmap.c:1476 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:4502 _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:3339 [inline] dir_emit_dots include/linux/fs.h:3350 [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:712 [inline] do_last fs/namei.c:3296 [inline] path_openat+0xd53/0x3520 fs/namei.c:3527 do_filp_open+0x25b/0x3b0 fs/namei.c:3562 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:2696 [inline] lo_write_bvec+0x23a/0x3b0 drivers/block/loop.c:271 lo_write_transfer drivers/block/loop.c:329 [inline] do_req_filebacked drivers/block/loop.c:573 [inline] loop_handle_cmd drivers/block/loop.c:1705 [inline] loop_queue_work+0x109d/0x3900 drivers/block/loop.c:1719 kthread_worker_fn+0x32b/0x980 kernel/kthread.c:635 loop_kthread_worker_fn+0x51/0x60 drivers/block/loop.c:836 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/7691: #0: (&x->wait#14){..-.}, at: [] complete+0x18/0x80 kernel/sched/completion.c:34 stack backtrace: CPU: 0 PID: 7691 Comm: loop0 Not tainted 4.14.0-rc4+ #128 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+0xe59/0x1d00 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+0x9c/0xd0 block/bio.c:930 bio_endio+0x2f8/0x8d0 block/bio.c:1855 req_bio_endio block/blk-core.c:204 [inline] blk_update_request+0x2a6/0xe20 block/blk-core.c:2746 blk_mq_end_request+0x54/0x120 block/blk-mq.c:509 lo_complete_rq+0xbe/0x1f0 drivers/block/loop.c:463 __blk_mq_complete_request+0x38f/0x6c0 block/blk-mq.c:550 blk_mq_complete_request+0x4f/0x60 block/blk-mq.c:570 loop_handle_cmd drivers/block/loop.c:1710 [inline] loop_queue_work+0x26b/0x3900 drivers/block/loop.c:1719 kthread_worker_fn+0x32b/0x980 kernel/kthread.c:635 loop_kthread_worker_fn+0x51/0x60 drivers/block/loop.c:836 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 SELinux: unknown mount option device lo entered promiscuous mode IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready kvm: vcpu 0: requested 68374 ns lapic timer period limited to 500000 ns kvm: vcpu 0: requested 68374 ns lapic timer period limited to 500000 ns 9pnet_virtio: no channels available for device ./bus TCP: request_sock_TCPv6: Possible SYN flooding on port 20001. Sending cookies. Check SNMP counters. 9pnet_virtio: no channels available for device ./bus audit: type=1326 audit(1507868732.767:696): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.789:697): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=53 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.789:698): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.789:699): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.810:700): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=85 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.810:701): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.810:702): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868732.832:703): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10298 comm="syz-executor2" exe="/root/syz-executor2" sig=0 arch=c000003e syscall=16 compat=0 ip=0x4520a9 code=0x7ffc0000 9pnet_virtio: no channels available for device ./bus 9pnet_virtio: no channels available for device ./bus sock: process `syz-executor6' is using obsolete setsockopt SO_BSDCOMPAT QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl sctp: [Deprecated]: syz-executor1 (pid 10379) Use of int in maxseg socket option. Use struct sctp_assoc_value instead QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl sctp: [Deprecated]: syz-executor1 (pid 10396) Use of int in maxseg socket option. Use struct sctp_assoc_value instead SELinux: unrecognized netlink message: protocol=0 nlmsg_type=1049 sclass=netlink_route_socket pig=10444 comm=syz-executor7 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=1049 sclass=netlink_route_socket pig=10444 comm=syz-executor7 device lo entered promiscuous mode sctp: [Deprecated]: syz-executor0 (pid 10555) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead device lo left promiscuous mode sctp: [Deprecated]: syz-executor0 (pid 10572) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead Started in network mode Own node address <101.1878.1395>, network identity 4711 nla_parse: 17 callbacks suppressed netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. device gre0 entered promiscuous mode kauditd_printk_skb: 71 callbacks suppressed audit: type=1326 audit(1507868734.879:775): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.886:776): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 rfkill: input handler disabled audit: type=1326 audit(1507868734.886:777): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=2 compat=0 ip=0x40c461 code=0x7ffc0000 rfkill: input handler enabled audit: type=1326 audit(1507868734.886:778): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:779): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:780): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=22 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:781): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:782): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:783): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=16 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868734.887:784): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=10699 comm=7F03 exe="/root/syz-executor4" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. QAT: Invalid ioctl netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. *** Guest State *** CR0: actual=0x0000000080000031, shadow=0x0000000060000031, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002050, shadow=0x0000000000000020, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 RFLAGS=0x00000002 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000f80 CS:RIP=0050:0000000000002810 CS: sel=0x0030, attr=0x0409b, limit=0x000fffff, base=0x0000000000000000 DS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 *** Guest State *** CR0: actual=0x0000000080000031, shadow=0x0000000060000031, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002050, shadow=0x0000000000000020, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 RFLAGS=0x00000002 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000f80 CS:RIP=0050:0000000000002810 CS: sel=0x0030, attr=0x0409b, limit=0x000fffff, base=0x0000000000000000 DS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 SS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 ES: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 FS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 GS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 GDTR: limit=0x000007ff, base=0x0000000000001000 LDTR: sel=0x0008, attr=0x04082, limit=0x000007ff, base=0x0000000000001800 IDTR: limit=0x000001ff, base=0x0000000000003800 TR: sel=0x0000, attr=0x0008b, limit=0x0000ffff, base=0x0000000000000000 EFER = 0x000000000000e000 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 Interruptibility = 00000000 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811ba1f3 RSP = 0xffff8801c57a74c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007f3ac2f30700 GSBase=ffff8801db300000 TRBase=ffff8801db3231c0 GDTBase=ffffffffff576000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=00000001c803b000 CR4=00000000001426e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84d45170 EFER = 0x0000000000000d01 PAT = 0x0000000000000000 *** Control State *** PinBased=0000003f CPUBased=b6a1edfa SecondaryExec=0000004b EntryControls=0000d1ff ExitControls=0023efff ExceptionBitmap=00060042 PFECmask=00000000 PFECmatch=00000000 VMEntry: intr_info=00000000 errcode=00000000 ilen=00000000 VMExit: intr_info=00000000 errcode=00000000 ilen=00000006 reason=80000021 qualification=0000000000000000 IDTVectoring: info=00000000 errcode=00000000 TSC Offset = 0xffffffcbe3f94d72 TPR Threshold = 0x00 EPT pointer = 0x00000001d0e2701e sg_write: data in/out 822404280/197 bytes for SCSI command 0x12-- guessing data in; program syz-executor0 not setting count and/or reply_len properly sg_write: data in/out 213832448/199 bytes for SCSI command 0xf-- guessing data in; program syz-executor0 not setting count and/or reply_len properly sg_write: data in/out 822404280/197 bytes for SCSI command 0x12-- guessing data in; program syz-executor0 not setting count and/or reply_len properly sg_write: data in/out 213832448/199 bytes for SCSI command 0xf-- guessing data in; program syz-executor0 not setting count and/or reply_len properly SS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 ES: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 FS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 GS: sel=0x0038, attr=0x04093, limit=0x000fffff, base=0x0000000000000000 GDTR: limit=0x000007ff, base=0x0000000000001000 LDTR: sel=0x0008, attr=0x04082, limit=0x000007ff, base=0x0000000000001800 IDTR: limit=0x000001ff, base=0x0000000000003800 TR: sel=0x0000, attr=0x0008b, limit=0x0000ffff, base=0x0000000000000000 EFER = 0x000000000000e000 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 Interruptibility = 00000000 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811ba1f3 RSP = 0xffff8801c1bcf4c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007f3ac2fb8700 GSBase=ffff8801db200000 TRBase=ffff8801db2231c0 GDTBase=ffffffffff577000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=00000001c803b000 CR4=00000000001426f0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84d45170 EFER = 0x0000000000000d01 PAT = 0x0000000000000000 *** Control State *** PinBased=0000003f CPUBased=b6a1edfa SecondaryExec=0000004b EntryControls=0000d1ff ExitControls=0023efff ExceptionBitmap=00060042 PFECmask=00000000 PFECmatch=00000000 VMEntry: intr_info=00000000 errcode=00000000 ilen=00000000 VMExit: intr_info=00000000 errcode=00000000 ilen=00000000 reason=80000021 qualification=0000000000000000 IDTVectoring: info=00000000 errcode=00000000 TSC Offset = 0xffffffcbf238675e TPR Threshold = 0x00 EPT pointer = 0x00000001c18a201e netlink: 8 bytes leftover after parsing attributes in process `syz-executor3'. 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: 357 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 netlink: 8 bytes leftover after parsing attributes in process `syz-executor3'. 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 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=3131 sclass=netlink_xfrm_socket pig=10887 comm=syz-executor7 print_req_error: I/O error, dev loop0, sector 0 Trying to set illegal importance in message 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 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=3131 sclass=netlink_xfrm_socket pig=10887 comm=syz-executor7 Trying to set illegal importance in message sock: sock_set_timeout: `syz-executor1' (pid 10930) tries to set negative timeout netlink: 1 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor7'. QAT: Invalid ioctl kvm: pic: level sensitive irq not supported SELinux: unrecognized netlink message: protocol=9 nlmsg_type=7681 sclass=netlink_audit_socket pig=11157 comm=syz-executor0 device syz7 entered promiscuous mode device syz7 left promiscuous mode device syz7 entered promiscuous mode SELinux: unrecognized netlink message: protocol=9 nlmsg_type=7681 sclass=netlink_audit_socket pig=11180 comm=syz-executor0 sock: sock_set_timeout: `syz-executor2' (pid 11226) tries to set negative timeout sock: sock_set_timeout: `syz-executor2' (pid 11188) tries to set negative timeout kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008f data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008e data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008d data 0x0 sctp: [Deprecated]: syz-executor6 (pid 11342) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor6 (pid 11347) Use of int in maxseg socket option. Use struct sctp_assoc_value instead kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008f data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008e data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008d data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008c data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008b data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x4000008a data 0x0 kvm [11297]: vcpu0, guest rIP: 0x9115 Hyper-V uhandled wrmsr: 0x40000089 data 0x0 sctp: [Deprecated]: syz-executor5 (pid 11393) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor5 (pid 11393) Use of int in maxseg socket option. Use struct sctp_assoc_value instead device syz4 left promiscuous mode *** Guest State *** CR0: actual=0x0000000080000031, shadow=0x0000000060000010, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002051, shadow=0x0000000000000000, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x000000000000fffa RIP = 0x0000000000000000 RFLAGS=0x00023000 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000000 CS:RIP=0000:0000000000000000 CS: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 DS: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 SS: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 ES: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 FS: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 GS: sel=0x0000, attr=0x000f3, limit=0x0000ffff, base=0x0000000000000000 GDTR: limit=0x0000ffff, base=0x0000000000000000 LDTR: sel=0x0000, attr=0x00082, limit=0x0000ffff, base=0x0000000000000000 IDTR: limit=0x0000ffff, base=0x0000000000000000 TR: sel=0x0000, attr=0x0008b, limit=0x00002088, base=0x0000000000000000 EFER = 0x0000000000000000 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 Interruptibility = 00000008 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811ba1f3 RSP = 0xffff8801d756f4c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007f559a0e8700 GSBase=ffff8801db300000 TRBase=ffff8801db3231c0 GDTBase=ffffffffff576000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=00000001d8030000 CR4=00000000001426e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84d45170 EFER = 0x0000000000000d01 PAT = 0x0000000000000000 *** Control State *** PinBased=0000003f CPUBased=b699edfa SecondaryExec=00000042 EntryControls=0000d1ff ExitControls=0023efff ExceptionBitmap=ffffbfff PFECmask=00000000 PFECmatch=00000000 VMEntry: intr_info=00000000 errcode=00007fff ilen=00000000 VMExit: intr_info=00000000 errcode=00000000 ilen=00000001 reason=80000021 qualification=0000000000000000 IDTVectoring: info=00000000 errcode=00000000 TSC Offset = 0xffffffc9ede4a72c EPT pointer = 0x00000001c560501e QAT: Invalid ioctl xprt_adjust_timeout: rq_timeout = 0! xprt_adjust_timeout: rq_timeout = 0! TCP: request_sock_TCP: Possible SYN flooding on port 20010. Sending cookies. Check SNMP counters. TCP: request_sock_TCP: Possible SYN flooding on port 20010. Sending cookies. Check SNMP counters. nla_parse: 22 callbacks suppressed netlink: 12 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. kauditd_printk_skb: 118 callbacks suppressed audit: type=1326 audit(1507868739.894:903): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=85 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.895:904): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.895:905): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.900:906): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=298 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.900:907): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.900:908): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.903:909): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=298 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.904:910): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.904:911): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=202 compat=0 ip=0x4520a9 code=0x7ffc0000 audit: type=1326 audit(1507868739.907:912): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=11839 comm="" exe="/root/syz-executor1" sig=0 arch=c000003e syscall=16 compat=0 ip=0x4520a9 code=0x7ffc0000 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=1042 sclass=netlink_route_socket pig=11953 comm=syz-executor0 loop: Write error at byte offset 18446744073709551614, length 4096. SELinux: unrecognized netlink message: protocol=0 nlmsg_type=1042 sclass=netlink_route_socket pig=11965 comm=syz-executor0 loop: Write error at byte offset 18446744073709551614, length 4096. SELinux: failure in selinux_parse_skb(), unable to parse packet SELinux: failure in selinux_parse_skb(), unable to parse packet kvm: vcpu 2: requested 68374 ns lapic timer period limited to 500000 ns SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=12243 comm=syz-executor7