====================================================== WARNING: possible circular locking dependency detected 4.13.0-rc6-next-20170825+ #9 Not tainted ------------------------------------------------------ kworker/0:1/37 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 insert transport fail, errno -17 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/0:1/37: #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: 0 PID: 37 Comm: kworker/0: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 QAT: Invalid ioctl QAT: Invalid ioctl device lo entered promiscuous mode sock: process `syz-executor4' is using obsolete getsockopt SO_BSDCOMPAT device lo left promiscuous mode TCP: request_sock_TCPv6: Possible SYN flooding on port 20020. Sending cookies. Check SNMP counters. devpts: called with bogus options 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 devpts: called with bogus options audit: type=1326 audit(1503783993.442:17): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5472 comm="syz-executor0" exe="/syz-executor0" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 Assertion failed! net/irda/ircomm/ircomm_core.c:ircomm_flow_request:475 self != NULL audit: type=1326 audit(1503783993.501:18): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5472 comm="syz-executor0" exe="/syz-executor0" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 rfkill: input handler disabled kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008f kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008e kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008d kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008c kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008b kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x4000008a kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000089 kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000088 kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000087 kvm [5538]: vcpu0, guest rIP: 0x9135 Hyper-V unhandled rdmsr: 0x40000086 kvm: vcpu 0: requested 316 ns lapic timer period limited to 500000 ns rfkill: input handler enabled QAT: Invalid ioctl QAT: Invalid ioctl 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? syz-executor7: vmalloc: allocation failure: 4294967353 bytes, mode:0x14000c0(GFP_KERNEL), nodemask=(null) syz-executor7 cpuset=/ mems_allowed=0-1 CPU: 2 PID: 5669 Comm: syz-executor7 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] xt_alloc_table_info+0x64/0xe0 net/netfilter/x_tables.c:1006 do_replace net/ipv6/netfilter/ip6_tables.c:1144 [inline] do_ip6t_set_ctl+0x276/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:00007f0ffb825c08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 0000000000446749 RDX: 0800000000000040 RSI: 0400000000000029 RDI: 0000000000000005 RBP: 0000000000708000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000020000000 R11: 0000000000000296 R12: 00000000ffffffff R13: 00000000000037d0 R14: 00000000006e5890 R15: 0000000000001000 warn_alloc_show_mem: 1 callbacks suppressed Mem-Info: active_anon:99768 inactive_anon:42 isolated_anon:0 active_file:3462 inactive_file:5698 isolated_file:0 unevictable:0 dirty:75 writeback:0 unstable:0 slab_reclaimable:5272 slab_unreclaimable:31915 mapped:20850 shmem:54 pagetables:818 bounce:0 free:246421 free_pcp:1101 free_cma:0 Node 0 active_anon:166920kB inactive_anon:76kB active_file:9548kB inactive_file:18540kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:39548kB dirty:208kB writeback:0kB shmem:116kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 22528kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 1 active_anon:236460kB inactive_anon:92kB active_file:4300kB inactive_file:4276kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:43852kB dirty:104kB writeback:0kB shmem:100kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 10240kB 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:583320kB min:36536kB low:45668kB high:54800kB active_anon:175244kB inactive_anon:76kB active_file:9548kB inactive_file:18540kB unevictable:0kB writepending:208kB present:1032192kB managed:909748kB mlocked:0kB kernel_stack:2720kB pagetables:1888kB bounce:0kB free_pcp:2500kB local_pcp:640kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 1 DMA32 free:386584kB min:30404kB low:38004kB high:45604kB active_anon:224172kB inactive_anon:92kB active_file:4300kB inactive_file:4276kB unevictable:0kB writepending:104kB present:1048560kB managed:755216kB mlocked:0kB kernel_stack:2656kB pagetables:1568kB bounce:0kB free_pcp:1828kB local_pcp:104kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 syz-executor7: vmalloc: allocation failure: 4294967353 bytes, mode:0x14000c0(GFP_KERNEL), nodemask=(null) syz-executor7 cpuset=/ mems_allowed=0-1 CPU: 1 PID: 5705 Comm: syz-executor7 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] xt_alloc_table_info+0x64/0xe0 net/netfilter/x_tables.c:1006 do_replace net/ipv6/netfilter/ip6_tables.c:1144 [inline] do_ip6t_set_ctl+0x276/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:00007f0ffb7c2c08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000006 RCX: 0000000000446749 RDX: 0800000000000040 RSI: 0400000000000029 RDI: 0000000000000006 RBP: 00000000007081f8 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000020000000 R11: 0000000000000296 R12: 00000000ffffffff R13: 0000000000000990 R14: 00000000006e2a50 R15: 0000000000000000 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 Node 0 DMA32: 313*4kB (UE) 1557*8kB (UME) 1645*16kB (UM) 1331*32kB (UME) 794*64kB (UME) 172*128kB (UM) 47*256kB (UME) 22*512kB (UM) 4*1024kB (UME) 5*2048kB (UM) 99*4096kB (M) = 598588kB nla_parse: 29 callbacks suppressed netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. Node 1 DMA32: 52*4kB (UE) 203*8kB (UME) 120*16kB (UE) 111*32kB (UME) 24*64kB (UME) 4*128kB (M) 11*256kB (UM) 19*512kB (UME) 9*1024kB (UE) 5*2048kB (UM) 79*4096kB (M) = 364936kB 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 8197 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 QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. device syz4 left promiscuous mode netlink: 5 bytes leftover after parsing attributes in process `syz-executor0'. QAT: Invalid ioctl QAT: Invalid ioctl netlink: 21 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 21 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor1'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor1'. *** Guest State *** CR0: actual=0x0000000000000031, shadow=0x0000000060000011, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002050, shadow=0x0000000000000010, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 RFLAGS=0x00000002 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000f80 CS:RIP=0030: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 = 00000009 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811b8fd7 RSP = 0xffff88005962f4c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007fcedda18700 GSBase=ffff88003ec00000 TRBase=ffff88003ec23100 GDTBase=ffffffffff577000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=0000000036496000 CR4=00000000000026f0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 *** Control State *** PinBased=0000003f CPUBased=b6a1edfe SecondaryExec=000000e3 EntryControls=0001d1ff ExitControls=00afefff 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 = 0xffffffde447abdd0 TPR Threshold = 0x00 EPT pointer = 0x000000003d00a01e Virtual processor ID = 0x0001 *** Guest State *** CR0: actual=0x0000000000000031, shadow=0x0000000060000011, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000002050, shadow=0x0000000000000010, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 RFLAGS=0x00000002 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000f80 CS:RIP=0030:0000000000002810 CS: sel=0x0900, attr=0x0409b, limit=0x000fffff, base=0x0000000000009000 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 = 00000009 ActivityState = 00000000 *** Host State *** RIP = 0xffffffff811b8fd7 RSP = 0xffff880054a3f4c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007fcedd9d4700 GSBase=ffff88006de00000 TRBase=ffff88006de23100 GDTBase=ffffffffff575000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=0000000036496000 CR4=00000000000026e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 *** Control State *** PinBased=0000003f CPUBased=b6a1edfe SecondaryExec=000000e3 EntryControls=0001d1ff ExitControls=00afefff 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 = 0xffffffde447abdd0 TPR Threshold = 0x00 EPT pointer = 0x000000003d00a01e Virtual processor ID = 0x0001 TCP: request_sock_TCPv6: Possible SYN flooding on port 20001. Sending cookies. Check SNMP counters. sg_write: data in/out 213971796/19 bytes for SCSI command 0x0-- guessing data in; program syz-executor1 not setting count and/or reply_len properly sg_write: data in/out 213971796/79 bytes for SCSI command 0x0-- guessing data in; program syz-executor0 not setting count and/or reply_len properly sg_write: data in/out 213971796/79 bytes for SCSI command 0x0-- guessing data in; program syz-executor0 not setting count and/or reply_len properly sctp: [Deprecated]: syz-executor6 (pid 6100) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor6 (pid 6100) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor6 (pid 6100) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor6 (pid 6100) Use of int in maxseg socket option. Use struct sctp_assoc_value instead netlink: 3 bytes leftover after parsing attributes in process `syz-executor5'. audit: type=1326 audit(1503783995.812:19): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6218 comm="syz-executor7" exe="/syz-executor7" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503783995.906:20): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6218 comm="syz-executor7" exe="/syz-executor7" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 ICMPv6: NA: someone advertises our address fe80:0000:0000:0000:0000:0000:0000:07aa on syz7! ICMPv6: NA: someone advertises our address fe80:0000:0000:0000:0000:0000:0000:07aa on syz7! audit: type=1326 audit(1503783996.126:21): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6317 comm="syz-executor0" exe="/syz-executor0" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503783996.225:22): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6317 comm="syz-executor0" exe="/syz-executor0" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 device lo entered promiscuous mode 9pnet_virtio: no channels available for device ./control 9pnet_virtio: no channels available for device ./control TCP: request_sock_TCP: Possible SYN flooding on port 20028. Sending cookies. Check SNMP counters. QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl device syz1 entered promiscuous mode device syz1 left promiscuous mode device syz1 entered promiscuous mode device syz6 left promiscuous mode IPv6: RTM_NEWROUTE with no NLM_F_CREATE or NLM_F_REPLACE IPv6: NLM_F_CREATE should be set when creating new route audit: type=1326 audit(1503783997.661:23): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6863 comm="syz-executor7" exe="/syz-executor7" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 IPv6: RTM_NEWROUTE with no NLM_F_CREATE or NLM_F_REPLACE audit: type=1326 audit(1503783997.756:24): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6863 comm="syz-executor7" exe="/syz-executor7" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 ICMPv6: NA: someone advertises our address fe80:0000:0000:0000:0000:0000:0000:05aa on syz5! ICMPv6: NA: someone advertises our address fe80:0000:0000:0000:0000:0000:0000:05aa on syz5! device lo entered promiscuous mode sctp: [Deprecated]: syz-executor0 (pid 7045) Use of int in max_burst socket option. Use struct sctp_assoc_value instead dccp_v6_rcv: dropped packet with invalid checksum dccp_v6_rcv: dropped packet with invalid checksum sctp: [Deprecated]: syz-executor0 (pid 7045) Use of int in max_burst socket option. Use struct sctp_assoc_value instead dccp_close: ABORT with 9617 bytes unread BUG: sleeping function called from invalid context at ./include/linux/uaccess.h:71 in_atomic(): 1, irqs_disabled(): 0, pid: 7247, name: syz-executor1 INFO: lockdep is turned off. CPU: 0 PID: 7247 Comm: syz-executor1 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 ___might_sleep+0x2b2/0x470 kernel/sched/core.c:6022 __might_sleep+0x95/0x190 kernel/sched/core.c:5975 __might_fault+0xab/0x1d0 mm/memory.c:4483 __copy_from_user include/linux/uaccess.h:71 [inline] paging32_walk_addr_generic+0x427/0x1e10 arch/x86/kvm/paging_tmpl.h:369 paging32_walk_addr arch/x86/kvm/paging_tmpl.h:475 [inline] paging32_gva_to_gpa+0xa5/0x230 arch/x86/kvm/paging_tmpl.h:913 kvm_read_guest_virt_helper+0xd8/0x140 arch/x86/kvm/x86.c:4427 kvm_read_guest_virt_system+0x3c/0x50 arch/x86/kvm/x86.c:4494 segmented_read_std+0x10c/0x180 arch/x86/kvm/emulate.c:822 em_fxrstor+0x27b/0x410 arch/x86/kvm/emulate.c:4025 x86_emulate_insn+0x55d/0x3cf0 arch/x86/kvm/emulate.c:5483 x86_emulate_instruction+0x411/0x1ca0 arch/x86/kvm/x86.c:5726 kvm_mmu_page_fault+0x1b0/0x2f0 arch/x86/kvm/mmu.c:4932 handle_ept_violation+0x194/0x540 arch/x86/kvm/vmx.c:6509 vmx_handle_exit+0x24b/0x1a60 arch/x86/kvm/vmx.c:8830 vcpu_enter_guest arch/x86/kvm/x86.c:7040 [inline] vcpu_run arch/x86/kvm/x86.c:7102 [inline] kvm_arch_vcpu_ioctl_run+0x1d36/0x5a30 arch/x86/kvm/x86.c:7263 kvm_vcpu_ioctl+0x64c/0x1010 arch/x86/kvm/../../../virt/kvm/kvm_main.c:2592 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 RIP: 0033:0x446749 RSP: 002b:00007ff1b10eec08 EFLAGS: 00000282 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 0000000000000019 RCX: 0000000000446749 RDX: 0000000000000000 RSI: 000000000000ae80 RDI: 0000000000000019 RBP: 0000000000708000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000282 R12: 00000000ffffffff R13: 0000000000001e10 R14: 00000000006e3ed0 R15: 000000008080aea1 ata1.00: invalid cdb length 11 ata1.00: invalid cdb length 11 kvm_hv_set_msr: 14 callbacks suppressed kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008f data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008e data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008d data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008c data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008b data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x4000008a data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000089 data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000088 data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000087 data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000086 data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000020 data 0xf0047 kvm [7326]: vcpu0, guest rIP: 0x9111 Hyper-V uhandled wrmsr: 0x40000020 data 0xf0047 ircomm ircomm7: ldisc open failed (-12), clearing slot 7 devpts: called with bogus options QAT: Invalid ioctl nla_parse: 20 callbacks suppressed netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. devpts: called with bogus options rpcbind: RPC call returned error 22 rpcbind: RPC call returned error 22 audit: type=1326 audit(1503783999.154:25): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7452 comm="syz-executor2" exe="/syz-executor2" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 netlink: 64 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 64 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. audit: type=1326 audit(1503783999.207:26): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7452 comm="syz-executor2" exe="/syz-executor2" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 netlink: 11 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 11 bytes leftover after parsing attributes in process `syz-executor7'. audit: type=1326 audit(1503783999.282:27): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7436 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503783999.484:28): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7436 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 sock: sock_set_timeout: `syz-executor7' (pid 7568) tries to set negative timeout netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor4'. audit: type=1326 audit(1503784000.073:29): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7532 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503784000.326:30): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7532 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503784001.231:31): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7780 comm="syz-executor5" exe="/syz-executor5" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503784001.271:32): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7780 comm="syz-executor5" exe="/syz-executor5" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 device lo left promiscuous mode sctp: [Deprecated]: syz-executor5 (pid 7983) Use of int in max_burst socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor5 (pid 8006) Use of int in max_burst socket option. Use struct sctp_assoc_value instead 9pnet_virtio: no channels available for device ./control/file0 syz-executor0: vmalloc: allocation failure: 17179869180 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor0 cpuset=/ mems_allowed=0-1 CPU: 2 PID: 8075 Comm: syz-executor0 Tainted: G W 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 9pnet_virtio: no channels available for device ./control/file0 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 tcp_setsockopt+0x82/0xd0 net/ipv4/tcp.c:2800 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 do_syscall_64+0x26c/0x8c0 arch/x86/entry/common.c:287 entry_SYSCALL64_slow_path+0x25/0x25 RIP: 0033:0x446749 RSP: 002b:00007f8767a0fc08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000018 RCX: 0000000000446749 RDX: 0000000000000040 RSI: 0000000000000029 RDI: 0000000000000018 RBP: 0000000000708000 R08: 0000000000000004 R09: 0000000000000000 R10: 0000000020001fde R11: 0000000000000296 R12: 00000000ffffffff R13: 0000000000004780 R14: 00000000006e6840 R15: 0000000000000029 warn_alloc_show_mem: 1 callbacks suppressed Mem-Info: active_anon:112955 inactive_anon:44 isolated_anon:0 active_file:3494 inactive_file:4787 isolated_file:0 unevictable:0 dirty:179 writeback:0 unstable:0 slab_reclaimable:5507 slab_unreclaimable:34853 mapped:20919 shmem:70 pagetables:845 bounce:0 free:230591 free_pcp:1122 free_cma:0 Node 0 active_anon:173940kB inactive_anon:92kB active_file:9628kB inactive_file:14396kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:39648kB dirty:392kB writeback:0kB shmem:184kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 12288kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 1 active_anon:267584kB inactive_anon:84kB active_file:4348kB inactive_file:4752kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:44028kB dirty:324kB writeback:0kB shmem:96kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 40960kB 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:554220kB min:36536kB low:45668kB high:54800kB active_anon:194524kB inactive_anon:92kB active_file:9628kB inactive_file:14396kB unevictable:0kB writepending:392kB present:1032192kB managed:909748kB mlocked:0kB kernel_stack:2656kB pagetables:1764kB bounce:0kB free_pcp:2112kB local_pcp:688kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 1 DMA32 free:361432kB min:30404kB low:38004kB high:45604kB active_anon:248912kB inactive_anon:84kB active_file:4348kB inactive_file:4752kB unevictable:0kB writepending:324kB present:1048560kB managed:755216kB mlocked:0kB kernel_stack:2816kB pagetables:1568kB bounce:0kB free_pcp:2120kB local_pcp:392kB 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 syz-executor0: vmalloc: allocation failure: 17179869180 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor0 cpuset=/ mems_allowed=0-1 CPU: 1 PID: 8099 Comm: syz-executor0 Tainted: G W 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 tcp_setsockopt+0x82/0xd0 net/ipv4/tcp.c:2800 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 do_syscall_64+0x26c/0x8c0 arch/x86/entry/common.c:287 entry_SYSCALL64_slow_path+0x25/0x25 RIP: 0033:0x446749 RSP: 002b:00007f87679acc08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000020 RCX: 0000000000446749 RDX: 0000000000000040 RSI: 0000000000000029 RDI: 0000000000000020 RBP: 00000000007081f8 R08: 0000000000000004 R09: 0000000000000000 R10: 0000000020001fde R11: 0000000000000296 R12: 00000000ffffffff R13: 0000000000004780 R14: 00000000006e6840 R15: 0000000000000029 QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl Node 0 DMA32: 225*4kB (UME) 416*8kB (UME) 1279*16kB (UM) 1324*32kB (UME) 797*64kB (UM) 161*128kB (UME) 25*256kB (UM) 5*512kB (UME) 11*1024kB (UM) 1*2048kB (U) 98*4096kB (M) = 562356kB Node 1 DMA32: 111*4kB (UME) 431*8kB (UME) 171*16kB (UME) 195*32kB (UME) 78*64kB (UME) 21*128kB (UME) 12*256kB (ME) 15*512kB (UM) 10*1024kB (UME) 2*2048kB (U) 68*4096kB (UM) = 324164kB 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 8354 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 device lo entered promiscuous mode PF_BRIDGE: br_mdb_parse() with invalid ifindex PF_BRIDGE: br_mdb_parse() with invalid ifindex