====================================================== WARNING: possible circular locking dependency detected 4.13.0-rc6-next-20170825+ #9 Not tainted ------------------------------------------------------ kworker/2:1/662 is trying to acquire lock: (&kvm->irqfds.resampler_lock){+.+.}, at: [] irqfd_resampler_shutdown+0xe3/0x6b0 arch/x86/kvm/../../../virt/kvm/eventfd.c:98 but task is already holding lock: ((&irqfd->shutdown)){+.+.}, at: [] process_one_work+0xb2c/0x1be0 kernel/workqueue.c:2094 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #2 ((&irqfd->shutdown)){+.+.}: process_one_work+0xba5/0x1be0 kernel/workqueue.c:2095 worker_thread+0x223/0x1860 kernel/workqueue.c:2233 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 0xffffffffffffffff -> #1 ((complete)&rcu.completion){+.+.}: check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x3286/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 kernel/sched/completion.c:122 [inline] wait_for_completion+0xc8/0x770 kernel/sched/completion.c:143 __synchronize_srcu+0x1b5/0x250 kernel/rcu/srcutree.c:898 synchronize_srcu_expedited kernel/rcu/srcutree.c:923 [inline] synchronize_srcu+0x1a3/0x560 kernel/rcu/srcutree.c:974 kvm_irqfd_assign arch/x86/kvm/../../../virt/kvm/eventfd.c:364 [inline] kvm_irqfd+0x994/0x1d50 arch/x86/kvm/../../../virt/kvm/eventfd.c:572 kvm_vm_ioctl+0x1079/0x1c40 arch/x86/kvm/../../../virt/kvm/kvm_main.c:3032 vfs_ioctl fs/ioctl.c:45 [inline] do_vfs_ioctl+0x1b1/0x1530 fs/ioctl.c:685 SYSC_ioctl fs/ioctl.c:700 [inline] SyS_ioctl+0x8f/0xc0 fs/ioctl.c:691 entry_SYSCALL_64_fastpath+0x1f/0xbe -> #0 (&kvm->irqfds.resampler_lock){+.+.}: check_prev_add+0x865/0x1520 kernel/locking/lockdep.c:1894 check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x3286/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 __mutex_lock_common kernel/locking/mutex.c:756 [inline] __mutex_lock+0x16f/0x1870 kernel/locking/mutex.c:893 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:908 irqfd_resampler_shutdown+0xe3/0x6b0 arch/x86/kvm/../../../virt/kvm/eventfd.c:98 irqfd_shutdown+0xd8/0x1a0 arch/x86/kvm/../../../virt/kvm/eventfd.c:137 process_one_work+0xbfd/0x1be0 kernel/workqueue.c:2098 worker_thread+0x223/0x1860 kernel/workqueue.c:2233 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 other info that might help us debug this: Chain exists of: &kvm->irqfds.resampler_lock --> (complete)&rcu.completion --> (&irqfd->shutdown) Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock((&irqfd->shutdown)); lock((complete)&rcu.completion); lock((&irqfd->shutdown)); lock(&kvm->irqfds.resampler_lock); *** DEADLOCK *** 2 locks held by kworker/2:1/662: #0: ("kvm-irqfd-cleanup"){++++}, at: [] __write_once_size include/linux/compiler.h:305 [inline] #0: ("kvm-irqfd-cleanup"){++++}, at: [] atomic64_set arch/x86/include/asm/atomic64_64.h:33 [inline] #0: ("kvm-irqfd-cleanup"){++++}, at: [] atomic_long_set include/asm-generic/atomic-long.h:56 [inline] #0: ("kvm-irqfd-cleanup"){++++}, at: [] set_work_data kernel/workqueue.c:617 [inline] #0: ("kvm-irqfd-cleanup"){++++}, at: [] set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: ("kvm-irqfd-cleanup"){++++}, at: [] process_one_work+0xad4/0x1be0 kernel/workqueue.c:2090 #1: ((&irqfd->shutdown)){+.+.}, at: [] process_one_work+0xb2c/0x1be0 kernel/workqueue.c:2094 stack backtrace: CPU: 2 PID: 662 Comm: kworker/2:1 Not tainted 4.13.0-rc6-next-20170825+ #9 Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Bochs 01/01/2011 Workqueue: kvm-irqfd-cleanup irqfd_shutdown 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 check_prevs_add kernel/locking/lockdep.c:2020 [inline] validate_chain kernel/locking/lockdep.c:2469 [inline] __lock_acquire+0x3286/0x4620 kernel/locking/lockdep.c:3498 lock_acquire+0x1d5/0x580 kernel/locking/lockdep.c:4002 __mutex_lock_common kernel/locking/mutex.c:756 [inline] __mutex_lock+0x16f/0x1870 kernel/locking/mutex.c:893 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:908 irqfd_resampler_shutdown+0xe3/0x6b0 arch/x86/kvm/../../../virt/kvm/eventfd.c:98 irqfd_shutdown+0xd8/0x1a0 arch/x86/kvm/../../../virt/kvm/eventfd.c:137 process_one_work+0xbfd/0x1be0 kernel/workqueue.c:2098 worker_thread+0x223/0x1860 kernel/workqueue.c:2233 kthread+0x39c/0x470 kernel/kthread.c:231 ret_from_fork+0x2a/0x40 arch/x86/entry/entry_64.S:431 netlink: 8 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 8 bytes leftover after parsing attributes in process `syz-executor4'. audit: type=1326 audit(1503893031.014:6): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5243 comm="syz-executor6" exe="/syz-executor6" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 audit: type=1326 audit(1503893031.114:7): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5243 comm="syz-executor6" exe="/syz-executor6" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor6'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor6'. kvm: MWAIT instruction emulated as NOP! *** Guest State *** CR0: actual=0x0000000080000031, shadow=0x00000000e0000011, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002060, shadow=0x0000000000000020, gh_mask=ffffffffffffe871 CR3 = 0x0000000000002000 RSP = 0x0000000000000000 RIP = 0x0000000000000000 RFLAGS=0x0004108c DR7 = 0x0000000000000400 Sysenter RSP=0000000000000f80 CS:RIP=0030:0000000000002810 CS: sel=0x0043, attr=0x040fb, limit=0x000fffff, base=0x0000000000000000 DS: sel=0x004b, attr=0x040f3, limit=0x000fffff, base=0x0000000000000000 SS: sel=0x004b, attr=0x040f3, limit=0x000fffff, base=0x0000000000000000 ES: sel=0x004b, attr=0x040f3, limit=0x000fffff, base=0x0000000000000000 FS: sel=0x004b, attr=0x040f3, limit=0x000fffff, base=0x0000000000000000 GS: sel=0x004b, attr=0x040f3, 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=0x00d8, attr=0x0008b, limit=0x000001ff, base=0x0000000000003a00 EFER = 0x0000000000000501 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 BndCfgS = 0x0000000000000000 Interruptibility = 00000000 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811b8fd7 RSP = 0xffff8800376174c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007f8a04bb0700 GSBase=ffff88006df00000 TRBase=ffff88006df23100 GDTBase=ffffffffff574000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=0000000036ed3000 CR4=00000000000026e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 *** Control State *** PinBased=0000003f CPUBased=b6a06dfa SecondaryExec=000000e3 EntryControls=0001d3ff ExitControls=00afefff ExceptionBitmap=00060042 PFECmask=00000000 PFECmatch=00000000 VMEntry: intr_info=00000b0d errcode=00000000 ilen=00000000 VMExit: intr_info=00000000 errcode=00000000 ilen=00000000 reason=80000021 qualification=0000000000000000 IDTVectoring: info=00000000 errcode=00000000 TSC Offset = 0xffffffc79085add4 TPR Threshold = 0x00 EPT pointer = 0x0000000067fbc01e Virtual processor ID = 0x0016 TCP: request_sock_TCP: Possible SYN flooding on port 20004. Sending cookies. Check SNMP counters. device syz3 entered promiscuous mode QAT: Invalid ioctl QAT: Invalid ioctl device syz3 left promiscuous mode QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl netlink: 1 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor1'. device lo entered promiscuous mode audit: type=1326 audit(1503893033.984:8): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5950 comm="syz-executor5" exe="/syz-executor5" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893034.051:9): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5950 comm="syz-executor5" exe="/syz-executor5" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 TCP: request_sock_TCP: Possible SYN flooding on port 20004. Sending cookies. Check SNMP counters. tmpfs: No value for mount option 'Em2?[f)ԇ$-tc%osXYQ-E FˬgKT\ê65Eq`UVͼLvT(b7OtBDbNZ' tmpfs: No value for mount option 'Em2?[f)ԇ$-tc%osXYQ-E FˬgKT\ê65Eq`UVͼLvT(b7OtBDbNZ' IPv6: Can't replace route, no match found IPv6: Can't replace route, no match found TCP: request_sock_TCP: Possible SYN flooding on port 20008. Sending cookies. Check SNMP counters. tty_warn_deprecated_flags: 'syz-executor5' is using deprecated serial flags (with no effect): 00000400 tty_warn_deprecated_flags: 'syz-executor5' is using deprecated serial flags (with no effect): 00000400 device lo entered promiscuous mode nla_parse: 4 callbacks suppressed netlink: 5 bytes leftover after parsing attributes in process `syz-executor2'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor2'. *** Guest State *** CR0: actual=0x0000000000000031, shadow=0x0000000060000031, gh_mask=fffffffffffffff7 device lo entered promiscuous mode CR4: actual=0x0000000000002050, shadow=0x0000000000000020, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 device lo left promiscuous mode 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 = 0x0000000000000001 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 BndCfgS = 0x0000000000000000 Interruptibility = 00000000 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811b8fd7 RSP = 0xffff88003c1a74c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007fafa0a48700 GSBase=ffff88006de00000 TRBase=ffff88006de23100 GDTBase=ffffffffff575000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=000000003d702000 CR4=00000000000026e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 *** Control State *** PinBased=0000003f CPUBased=b699edfe SecondaryExec=000000e2 EntryControls=0001d1ff ExitControls=00afefff ExceptionBitmap=00060042 PFECmask=00000000 PFECmatch=00000000 VMEntry: intr_info=80000001 errcode=00000000 ilen=00000000 VMExit: intr_info=00000000 errcode=00000000 ilen=00000000 reason=80000021 qualification=0000000000000000 IDTVectoring: info=00000000 errcode=00000000 TSC Offset = 0xffffffc4bb2ca2d0 EPT pointer = 0x0000000053bbd01e Virtual processor ID = 0x0063 device lo entered promiscuous mode device lo left promiscuous mode audit: type=1326 audit(1503893035.166:10): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6373 comm="syz-executor5" exe="/syz-executor5" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. sg_write: data in/out 3171656/194 bytes for SCSI command 0x2a-- guessing data in; program syz-executor6 not setting count and/or reply_len properly sg_write: data in/out 3171656/194 bytes for SCSI command 0x2a-- guessing data in; program syz-executor6 not setting count and/or reply_len properly netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor1'. audit: type=1326 audit(1503893035.269:11): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6373 comm="syz-executor5" exe="/syz-executor5" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=65535 sclass=netlink_route_socket pig=6424 comm=syz-executor3 RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? syz-executor3: vmalloc: allocation failure: 17179869180 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor3 cpuset=/ mems_allowed=0-1 CPU: 2 PID: 6424 Comm: syz-executor3 Not tainted 4.13.0-rc6-next-20170825+ #9 Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Bochs 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:16 [inline] dump_stack+0x194/0x257 lib/dump_stack.c:52 warn_alloc+0x1c2/0x2f0 mm/page_alloc.c:3254 __vmalloc_node_range+0x599/0x730 mm/vmalloc.c:1781 __vmalloc_node mm/vmalloc.c:1810 [inline] __vmalloc_node_flags_caller+0x50/0x60 mm/vmalloc.c:1832 kvmalloc_node+0x82/0xd0 mm/util.c:406 kvmalloc include/linux/mm.h:529 [inline] kvmalloc_array include/linux/mm.h:545 [inline] xt_alloc_entry_offsets+0x21/0x30 net/netfilter/x_tables.c:774 translate_table+0x235/0x1690 net/ipv6/netfilter/ip6_tables.c:711 do_replace net/ipv6/netfilter/ip6_tables.c:1155 [inline] do_ip6t_set_ctl+0x34b/0x5c0 net/ipv6/netfilter/ip6_tables.c:1681 nf_sockopt net/netfilter/nf_sockopt.c:105 [inline] nf_setsockopt+0x67/0xc0 net/netfilter/nf_sockopt.c:114 ipv6_setsockopt+0x115/0x150 net/ipv6/ipv6_sockglue.c:920 rawv6_setsockopt+0x4a/0xf0 net/ipv6/raw.c:1059 sock_common_setsockopt+0x95/0xd0 net/core/sock.c:2970 SYSC_setsockopt net/socket.c:1852 [inline] SyS_setsockopt+0x189/0x360 net/socket.c:1831 entry_SYSCALL_64_fastpath+0x1f/0xbe RIP: 0033:0x446749 RSP: 002b:00007f6767a92c08 EFLAGS: 00000292 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 000000000000001b RCX: 0000000000446749 RDX: 0800000000000040 RSI: 0400000000000029 RDI: 000000000000001b RBP: 0000000000708000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000020000000 R11: 0000000000000292 R12: 0000000000708010 R13: 0000000000003240 R14: 00000000006e5300 R15: 00007f6767a93700 Mem-Info: active_anon:99828 inactive_anon:66 isolated_anon:0 active_file:3453 inactive_file:4724 isolated_file:0 unevictable:5 dirty:70 writeback:0 unstable:0 slab_reclaimable:5209 slab_unreclaimable:32081 mapped:20887 shmem:809 pagetables:834 bounce:0 free:245630 free_pcp:1109 free_cma:0 RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? SELinux: unrecognized netlink message: protocol=0 nlmsg_type=65535 sclass=netlink_route_socket pig=6432 comm=syz-executor3 Node 0 active_anon:207508kB inactive_anon:92kB active_file:6496kB inactive_file:15036kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:40924kB dirty:68kB writeback:0kB shmem:144kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 18432kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 1 active_anon:203248kB inactive_anon:92kB active_file:7312kB inactive_file:3864kB unevictable:20kB isolated(anon):0kB isolated(file):0kB mapped:42648kB dirty:220kB writeback:0kB shmem:112kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 47104kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 0 DMA free:15908kB min:640kB low:800kB high:960kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB lowmem_reserve[]: 0 886 886 886 Node 0 DMA32 free:555428kB min:36536kB low:45668kB high:54800kB active_anon:207508kB inactive_anon:92kB active_file:6496kB inactive_file:15036kB unevictable:0kB writepending:68kB present:1032192kB managed:909748kB mlocked:0kB kernel_stack:3104kB pagetables:1604kB bounce:0kB free_pcp:1892kB local_pcp:648kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 1 DMA32 free:401632kB min:30404kB low:38004kB high:45604kB active_anon:203248kB inactive_anon:92kB active_file:7312kB inactive_file:3864kB unevictable:20kB writepending:220kB present:1048560kB managed:755216kB mlocked:20kB kernel_stack:2144kB pagetables:1764kB bounce:0kB free_pcp:2560kB local_pcp:520kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15908kB loop_reread_partitions: partition scan of loop0 (-\t@r9hxGQ:[il L*@R-Tr-x) failed (rc=-13) print_req_error: I/O error, dev loop0, sector 0 print_req_error: I/O error, dev loop0, sector 0 Buffer I/O error on dev loop0, logical block 0, async page read netlink: 64 bytes leftover after parsing attributes in process `syz-executor1'. Node 0 DMA32: 145*4kB (UME) 93*8kB (UME) 387*16kB (ME) 412*32kB (UM) 176*64kB (UME) 62*128kB (UM) 24*256kB (UM) 9*512kB (UME) 9*1024kB (UME) 4*2048kB (UM) 121*4096kB (M) = 563676kB Node 1 DMA32: 22*4kB (ME) 93*8kB (UME) 21*16kB (UME) 586*32kB (UME) 594*64kB (UME) 303*128kB (UM) 116*256kB (UME) 20*512kB (UME) 3*1024kB (UM) 1*2048kB (M) 63*4096kB (M) = 399824kB 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 netlink: 64 bytes leftover after parsing attributes in process `syz-executor1'. Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB Node 1 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB 9450 total pagecache pages 0 pages in swap cache Swap cache stats: add 0, delete 0, find 0/0 Free swap = 0kB Total swap = 0kB 524186 pages RAM 0 pages HighMem/MovableOnly 103968 pages reserved netlink: 5 bytes leftover after parsing attributes in process `syz-executor6'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor6'. SELinux: unrecognized netlink message: protocol=4 nlmsg_type=5955 sclass=netlink_tcpdiag_socket pig=6602 comm=syz-executor3 SELinux: unrecognized netlink message: protocol=4 nlmsg_type=0 sclass=netlink_tcpdiag_socket pig=6611 comm=syz-executor3 QAT: Invalid ioctl QAT: Invalid ioctl kvm [6758]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 kvm [6758]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 RDS: rds_bind could not find a transport for 172.20.3.187, load rds_tcp or rds_rdma? 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 kvm [6998]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 QAT: Invalid ioctl kvm [6998]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 QAT: Invalid ioctl audit: type=1326 audit(1503893037.249:12): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7066 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893037.281:13): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7066 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893037.343:14): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7066 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893037.365:15): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7066 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 PF_BRIDGE: RTM_SETLINK with unknown ifindex PF_BRIDGE: RTM_SETLINK with unknown ifindex sctp: [Deprecated]: syz-executor5 (pid 7120) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sock: sock_set_timeout: `syz-executor7' (pid 7185) tries to set negative timeout sctp: [Deprecated]: syz-executor5 (pid 7120) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead Assertion failed! net/irda/ircomm/ircomm_core.c:ircomm_flow_request:475 self != NULL device syz6 left promiscuous mode audit: type=1326 audit(1503893037.799:16): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7349 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893037.841:17): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7349 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 syz-executor6 (7387) used greatest stack depth: 14096 bytes left *** Guest State *** CR0: actual=0x0000000000000030, shadow=0x0000000060000010, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002050, shadow=0x0000000000000000, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000000 RIP = 0x000000000000fff0 RFLAGS=0x00010100 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000000 CS:RIP=0000:0000000000000000 CS: sel=0xf000, attr=0x0009b, limit=0x0000ffff, base=0x00000000ffff0000 DS: sel=0x0000, attr=0x00093, limit=0x0000ffff, base=0x0000000000000000 SS: sel=0x0000, attr=0x00093, limit=0x0000ffff, base=0x0000000000000000 ES: sel=0x0000, attr=0x00093, limit=0x0000ffff, base=0x0000000000000000 FS: sel=0x0000, attr=0x00093, limit=0x0000ffff, base=0x0000000000000000 GS: sel=0x0000, attr=0x00093, 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=0x0000ffff, base=0x0000000000000000 EFER = 0x0000000000000000 PAT = 0x0007040600070406 DebugCtl = 0x0000000000000000 DebugExceptions = 0x0000000000000000 BndCfgS = 0x0000000000000000 Interruptibility = 00000000 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811b8fd7 RSP = 0xffff880053b8f4c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007fbc21b63700 GSBase=ffff88003ed00000 TRBase=ffff88006df23100 GDTBase=ffffffffff574000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=0000000038b81000 CR4=00000000000026e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 audit: type=1326 audit(1503893037.923:18): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7349 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 *** Control State *** audit: type=1326 audit(1503893037.927:19): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7349 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 PinBased=0000003f CPUBased=b699edfa SecondaryExec=000000e2 EntryControls=0001d1ff ExitControls=00afefff ExceptionBitmap=0006004a 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 = 0xffffffc26a7a545c EPT pointer = 0x000000003d00601e Virtual processor ID = 0x007d sctp: [Deprecated]: syz-executor7 (pid 7557) Use of int in maxseg socket option. Use struct sctp_assoc_value instead device lo entered promiscuous mode device lo left promiscuous mode kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008f kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008e kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008d kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008c kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008b kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008a kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000089 kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000088 kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000087 kvm [7640]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000086 device lo entered promiscuous mode device lo left promiscuous mode kvm_hv_set_msr: 11 callbacks suppressed kvm [7640]: vcpu0, guest rIP: 0x9112 Hyper-V uhandled wrmsr: 0x40000023 data 0x66c900003b9a1043 kvm [7640]: vcpu0, guest rIP: 0x9112 Hyper-V uhandled wrmsr: 0x40000022 data 0x66c90000cb211043 kvm [7640]: vcpu0, guest rIP: 0x9112 Hyper-V uhandled wrmsr: 0x40000020 data 0x66c9000000081043 sctp: [Deprecated]: syz-executor7 (pid 7717) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor4 (pid 7729) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor4 (pid 7746) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor7 (pid 7717) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? audit: type=1326 audit(1503893039.014:20): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7841 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503893039.088:21): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7841 comm="syz-executor3" exe="/syz-executor3" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 sock: sock_set_timeout: `syz-executor7' (pid 7932) tries to set negative timeout sock: sock_set_timeout: `syz-executor7' (pid 7932) tries to set negative timeout SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=7961 comm=syz-executor5 sg_write: data in/out 327773/154 bytes for SCSI command 0x51-- guessing data in; program syz-executor6 not setting count and/or reply_len properly sg_write: data in/out 327773/154 bytes for SCSI command 0x51-- guessing data in; program syz-executor6 not setting count and/or reply_len properly IPv6: NLM_F_REPLACE set, but no existing node found! IPv6: NLM_F_REPLACE set, but no existing node found! SELinux: unrecognized netlink message: protocol=6 nlmsg_type=5 sclass=netlink_xfrm_socket pig=8166 comm=syz-executor3 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=6 sclass=netlink_route_socket pig=8221 comm=syz-executor2 nla_parse: 24 callbacks suppressed netlink: 64 bytes leftover after parsing attributes in process `syz-executor5'. netlink: 64 bytes leftover after parsing attributes in process `syz-executor5'. SELinux: unrecognized netlink message: protocol=0 nlmsg_type=6 sclass=netlink_route_socket pig=8257 comm=syz-executor2 loop_reread_partitions: partition scan of loop0 () failed (rc=-13) kvm: vcpu 0: requested 316 ns lapic timer period limited to 500000 ns kvm: vcpu 0: requested 316 ns lapic timer period limited to 500000 ns 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? TCP: request_sock_TCPv6: Possible SYN flooding on port 20029. Sending cookies. Check SNMP counters. device lo entered promiscuous mode IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready