====================================================== WARNING: possible circular locking dependency detected 4.13.0-rc6-next-20170825+ #9 Not tainted ------------------------------------------------------ kworker/1:2/1256 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/1:2/1256: #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: 1 PID: 1256 Comm: kworker/1:2 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 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=256 sclass=netlink_route_socket pig=4769 comm=syz-executor5 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=256 sclass=netlink_route_socket pig=4769 comm=syz-executor5 RDS: rds_bind could not find a transport for 172.20.5.187, load rds_tcp or rds_rdma? kvm [4813]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 kvm [4813]: vcpu0, guest rIP: 0x9138 Hyper-V uhandled wrmsr: 0x40000020 data 0x400 QAT: Invalid ioctl QAT: Invalid ioctl *** Guest State *** CR0: actual=0x0000000000000030, shadow=0x0000000060000010, gh_mask=fffffffffffffff7 CR4: actual=0x0000000000022050, shadow=0x0000000000020000, gh_mask=ffffffffffffe871 CR3 = 0x00000000fffbc000 RSP = 0x0000000000000f80 RIP = 0x0000000000000000 RFLAGS=0x00000002 DR7 = 0x0000000000000400 Sysenter RSP=0000000000000000 CS:RIP=0000:0000000000000000 CS: sel=0x0010, attr=0x0009b, limit=0x000fffff, base=0x0000000000000000 DS: sel=0x0018, attr=0x00093, limit=0x000fffff, base=0x0000000000000000 SS: sel=0x0018, attr=0x00093, limit=0x000fffff, base=0x0000000000000000 ES: sel=0x0018, attr=0x00093, limit=0x000fffff, base=0x0000000000000000 FS: sel=0x0018, attr=0x00093, limit=0x000fffff, base=0x0000000000000000 GS: sel=0x0018, attr=0x00093, limit=0x000fffff, base=0x0000000000000000 GDTR: limit=0x000007ff, base=0x0000000000001000 LDTR: sel=0x0008, attr=0x04082, limit=0x000007ff, base=0x0000000000001800 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 = 0xffff880038e474c8 CS=0010 SS=0018 DS=0000 ES=0000 FS=0000 GS=0000 TR=0040 FSBase=00007ffa2ea3b700 GSBase=ffff88006df00000 TRBase=ffff88006df23100 GDTBase=ffffffffff574000 IDTBase=ffffffffff57b000 CR0=0000000080050033 CR3=000000006cc90000 CR4=00000000000026e0 Sysenter RSP=0000000000000000 CS:RIP=0010:ffffffff84da5a70 EFER = 0x0000000000000d01 PAT = 0x0007040600070406 *** Control State *** PinBased=0000003f CPUBased=b6a1edfa 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 = 0xffffffdda730fb3e TPR Threshold = 0x00 EPT pointer = 0x000000006b4bd01e Virtual processor ID = 0x0040 QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl kvm: MWAIT instruction emulated as NOP! device lo entered promiscuous mode kvm [5059]: vcpu0, guest rIP: 0xfff0 kvm_set_msr_common: MSR_IA32_DEBUGCTLMSR 0x2, nop SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=5078 comm=syz-executor6 kvm [5059]: vcpu0, guest rIP: 0xfff0 kvm_set_msr_common: MSR_IA32_DEBUGCTLMSR 0x2, nop ALSA: seq fatal error: cannot create timer (-22) kvm [5091]: vcpu0, guest rIP: 0x9112 Hyper-V uhandled wrmsr: 0x40000020 data 0xb syz-executor6: vmalloc: allocation failure: 4833356120 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor6 cpuset=/ mems_allowed=0-1 CPU: 0 PID: 5187 Comm: syz-executor6 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/0x1610 net/ipv4/netfilter/ip_tables.c:692 do_replace net/ipv4/netfilter/ip_tables.c:1135 [inline] do_ipt_set_ctl+0x34b/0x5c0 net/ipv4/netfilter/ip_tables.c:1669 nf_sockopt net/netfilter/nf_sockopt.c:105 [inline] nf_setsockopt+0x67/0xc0 net/netfilter/nf_sockopt.c:114 ip_setsockopt+0xa1/0xb0 net/ipv4/ip_sockglue.c:1251 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 entry_SYSCALL_64_fastpath+0x1f/0xbe RIP: 0033:0x446749 RSP: 002b:00007f1832b64c08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 000000000000001a RCX: 0000000000446749 RDX: 0000000000000040 RSI: 0000000000000000 RDI: 000000000000001a RBP: 0000000000708000 R08: 0000000000000056 R09: 0000000000000000 R10: 0000000020006000 R11: 0000000000000296 R12: 00000000ffffffff R13: 00000000000056b0 R14: 00000000006e7770 R15: 0000200000000004 warn_alloc_show_mem: 1 callbacks suppressed Mem-Info: active_anon:97025 inactive_anon:45 isolated_anon:0 active_file:3442 inactive_file:4726 isolated_file:0 unevictable:0 dirty:233 writeback:0 unstable:0 slab_reclaimable:5317 slab_unreclaimable:33944 mapped:20840 shmem:64 pagetables:815 bounce:0 free:248155 free_pcp:1007 free_cma:0 Node 0 active_anon:111176kB inactive_anon:108kB active_file:5580kB inactive_file:2460kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:34904kB dirty:184kB writeback:0kB shmem:160kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 10240kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 1 active_anon:274984kB inactive_anon:72kB active_file:8188kB inactive_file:16444kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:48404kB dirty:748kB writeback:0kB shmem:96kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 12288kB 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:658452kB min:36536kB low:45668kB high:54800kB active_anon:115720kB inactive_anon:112kB active_file:5584kB inactive_file:2472kB unevictable:0kB writepending:204kB present:1032192kB managed:909748kB mlocked:0kB kernel_stack:3168kB pagetables:1388kB bounce:0kB free_pcp:1720kB local_pcp:692kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 1 DMA32 free:313944kB min:30404kB low:38004kB high:45604kB active_anon:274984kB inactive_anon:68kB active_file:8188kB inactive_file:16444kB unevictable:0kB writepending:748kB present:1048560kB managed:755216kB mlocked:0kB kernel_stack:2336kB pagetables:1968kB bounce:0kB free_pcp:2336kB local_pcp:336kB 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 Node 0 DMA32: 451*4kB (UE) 272*8kB (UE) 291*16kB (UME) 293*32kB (UM) 105*64kB (UME) 45*128kB (UME) 27*256kB (UME) 14*512kB (UM) 9*1024kB (UME) 3*2048kB (UM) 146*4096kB (M) = 657948kB Node 1 DMA32: 0*4kB 389*8kB (UE) 1515*16kB (UM) 1021*32kB (UM) 690*64kB (UME) 230*128kB (UM) 70*256kB (UME) 2*512kB (UM) 3*1024kB (ME) 2*2048kB (UM) 35*4096kB (M) = 303096kB 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 8233 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 syz-executor6: vmalloc: allocation failure: 4833356120 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor6 cpuset=/ mems_allowed=0-1 CPU: 2 PID: 5227 Comm: syz-executor6 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/0x1610 net/ipv4/netfilter/ip_tables.c:692 do_replace net/ipv4/netfilter/ip_tables.c:1135 [inline] do_ipt_set_ctl+0x34b/0x5c0 net/ipv4/netfilter/ip_tables.c:1669 nf_sockopt net/netfilter/nf_sockopt.c:105 [inline] nf_setsockopt+0x67/0xc0 net/netfilter/nf_sockopt.c:114 ip_setsockopt+0xa1/0xb0 net/ipv4/ip_sockglue.c:1251 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 entry_SYSCALL_64_fastpath+0x1f/0xbe RIP: 0033:0x446749 RSP: 002b:00007f1832ae0c08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 000000000000001a RCX: 0000000000446749 RDX: 0000000000000040 RSI: 0000000000000000 RDI: 000000000000001a RBP: 0000000000a5f870 R08: 0000000000000056 R09: 0000000000000000 R10: 0000000020006000 R11: 0000000000000296 R12: 0000000000000000 R13: 0000000000000000 R14: 00007f1832ae19c0 R15: 00007f1832ae1700 Scheduler tracepoints stat_sleep, stat_iowait, stat_blocked and stat_runtime require the kernel parameter schedstats=enable or kernel.sched_schedstats=1 QAT: Invalid ioctl QAT: Invalid ioctl sg_write: data in/out 213971796/19 bytes for SCSI command 0x0-- guessing data in; program syz-executor7 not setting count and/or reply_len properly nla_parse: 13 callbacks suppressed netlink: 3 bytes leftover after parsing attributes in process `syz-executor6'. sg_write: data in/out 213971796/19 bytes for SCSI command 0x0-- guessing data in; program syz-executor7 not setting count and/or reply_len properly netlink: 3 bytes leftover after parsing attributes in process `syz-executor6'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. kauditd_printk_skb: 1358 callbacks suppressed audit: type=1326 audit(1503819243.934:1369): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5622 comm="syz-executor4" exe="/syz-executor4" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503819244.014:1370): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5622 comm="syz-executor4" exe="/syz-executor4" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 sctp: [Deprecated]: syz-executor4 (pid 5674) Use of int in max_burst socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor4 (pid 5674) Use of int in max_burst socket option. Use struct sctp_assoc_value instead device lo left promiscuous mode device lo entered promiscuous mode device lo left promiscuous mode QAT: Invalid ioctl netlink: 1 bytes leftover after parsing attributes in process `syz-executor3'. 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-executor3'. QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl audit: type=1326 audit(1503819244.448:1371): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5759 comm="syz-executor4" exe="/syz-executor4" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503819244.548:1372): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5759 comm="syz-executor4" exe="/syz-executor4" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503819244.705:1373): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5902 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503819244.815:1374): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=5902 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 netlink: 11 bytes leftover after parsing attributes in process `syz-executor2'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor1'. RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? audit: type=1326 audit(1503819245.052:1375): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6023 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 RDS: rds_bind could not find a transport for 224.0.0.1, load rds_tcp or rds_rdma? audit: type=1326 audit(1503819245.117:1376): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6023 comm="syz-executor1" exe="/syz-executor1" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=6093 comm=syz-executor0 QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl QAT: Invalid ioctl netlink: 13 bytes leftover after parsing attributes in process `syz-executor5'. netlink: 13 bytes leftover after parsing attributes in process `syz-executor5'. device syz3 entered promiscuous mode device syz3 left promiscuous mode device syz3 entered promiscuous mode IPv6: NLM_F_REPLACE set, but no existing node found! IPv6: NLM_F_REPLACE set, but no existing node found! QAT: Invalid ioctl QAT: Invalid ioctl audit: type=1326 audit(1503819246.086:1377): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6321 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 audit: type=1326 audit(1503819246.136:1378): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=6321 comm="syz-executor6" exe="/syz-executor6" sig=31 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0xffff0000 sctp: [Deprecated]: syz-executor7 (pid 6492) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead device syz5 left promiscuous mode device syz6 entered promiscuous mode TCP: request_sock_TCP: Possible SYN flooding on port 20012. Sending cookies. Check SNMP counters. 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 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 PF_BRIDGE: br_mdb_parse() with non-bridge SELinux: unrecognized netlink message: protocol=0 nlmsg_type=59666 sclass=netlink_route_socket pig=6950 comm=syz-executor7 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=59666 sclass=netlink_route_socket pig=6950 comm=syz-executor7 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=6952 comm=syz-executor5 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? SELinux: unrecognized netlink message: protocol=4 nlmsg_type=46560 sclass=netlink_tcpdiag_socket pig=7100 comm=syz-executor7 SELinux: unrecognized netlink message: protocol=4 nlmsg_type=46560 sclass=netlink_tcpdiag_socket pig=7143 comm=syz-executor7 device lo entered promiscuous mode rfkill: input handler disabled rfkill: input handler enabled Can not set IPV6_FL_F_REFLECT if flowlabel_consistency sysctl is enable do_dccp_setsockopt: sockopt(CHANGE_L/R) is deprecated: fix your app Can not set IPV6_FL_F_REFLECT if flowlabel_consistency sysctl is enable do_dccp_setsockopt: sockopt(CHANGE_L/R) is deprecated: fix your app kauditd_printk_skb: 6 callbacks suppressed audit: type=1326 audit(1503819249.022:1385): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7471 comm="syz-executor7" exe="/syz-executor7" sig=9 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x0 loop: Write error at byte offset 18446744073709551613, length 4096. loop: Write error at byte offset 18446744073709551613, length 4096. syz-executor1 (7615) used greatest stack depth: 14360 bytes left nla_parse: 26 callbacks suppressed netlink: 8 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 8 bytes leftover after parsing attributes in process `syz-executor7'. RDS: rds_bind could not find a transport for 172.20.5.187, load rds_tcp or rds_rdma? sctp: [Deprecated]: syz-executor6 (pid 7738) Use of int in max_burst socket option. Use struct sctp_assoc_value instead SELinux: unrecognized netlink message: protocol=0 nlmsg_type=123 sclass=netlink_route_socket pig=7747 comm=syz-executor0 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=7747 comm=syz-executor0 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=123 sclass=netlink_route_socket pig=7747 comm=syz-executor0 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=7763 comm=syz-executor0 sctp: [Deprecated]: syz-executor6 (pid 7774) Use of int in max_burst socket option. Use struct sctp_assoc_value instead TCP: request_sock_TCP: Possible SYN flooding on port 20016. Sending cookies. Check SNMP counters. netlink: 3 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 11 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 9 bytes leftover after parsing attributes in process `syz-executor5'. sctp: [Deprecated]: syz-executor7 (pid 7905) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead sctp: [Deprecated]: syz-executor7 (pid 7905) Use of int in maxseg socket option. Use struct sctp_assoc_value instead sctp: [Deprecated]: syz-executor7 (pid 7905) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead SELinux: unrecognized netlink message: protocol=4 nlmsg_type=5955 sclass=netlink_tcpdiag_socket pig=7906 comm=syz-executor2 sctp: [Deprecated]: syz-executor7 (pid 7913) Use of int in maxseg socket option. Use struct sctp_assoc_value instead SELinux: unrecognized netlink message: protocol=4 nlmsg_type=5955 sclass=netlink_tcpdiag_socket pig=7922 comm=syz-executor2 netlink: 3 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 11 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor2'. SELinux: unknown mount option SELinux: unknown mount option netlink: 3 bytes leftover after parsing attributes in process `syz-executor2'. audit: type=1326 audit(1503819250.861:1386): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.868:1387): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.869:1388): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.869:1389): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.869:1390): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.870:1391): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.870:1392): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.870:1393): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 audit: type=1326 audit(1503819250.870:1394): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=kernel pid=7984 comm="syz-executor2" exe="/syz-executor2" sig=0 arch=c000003e syscall=202 compat=0 ip=0x446749 code=0x50000 RDS: rds_bind could not find a transport for 172.20.6.187, load rds_tcp or rds_rdma? RDS: rds_bind could not find a transport for 172.20.6.187, load rds_tcp or rds_rdma? syz-executor6: vmalloc: allocation failure: 17179869180 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor6 cpuset=/ mems_allowed=0-1 CPU: 2 PID: 8158 Comm: syz-executor6 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 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 entry_SYSCALL_64_fastpath+0x1f/0xbe RIP: 0033:0x446749 RSP: 002b:00007f1832b43c08 EFLAGS: 00000296 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000018 RCX: 0000000000446749 RDX: 0000000000000040 RSI: 0000000000000029 RDI: 0000000000000018 RBP: 0000000000a5f870 R08: 0000000000000004 R09: 0000000000000000 R10: 0000000020001fde R11: 0000000000000296 R12: 0000000000000000 R13: 0000000000000000 R14: 00007f1832b449c0 R15: 00007f1832b44700 warn_alloc_show_mem: 1 callbacks suppressed Mem-Info: active_anon:120618 inactive_anon:42 isolated_anon:0 active_file:3506 inactive_file:4771 isolated_file:0 unevictable:0 dirty:143 writeback:0 unstable:0 slab_reclaimable:5842 slab_unreclaimable:34560 mapped:20909 shmem:66 pagetables:886 bounce:0 free:222569 free_pcp:1027 free_cma:0 Node 0 active_anon:128824kB inactive_anon:104kB active_file:5608kB inactive_file:2696kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:35108kB dirty:188kB writeback:0kB shmem:172kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 2048kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no Node 1 active_anon:337288kB inactive_anon:64kB active_file:8416kB inactive_file:20380kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:48628kB dirty:384kB writeback:0kB shmem:92kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 49152kB 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:631668kB min:36536kB low:45668kB high:54800kB active_anon:128816kB inactive_anon:104kB active_file:5608kB inactive_file:2708kB unevictable:0kB writepending:192kB present:1032192kB managed:909748kB mlocked:0kB kernel_stack:3008kB pagetables:1428kB bounce:0kB free_pcp:2536kB local_pcp:628kB free_cma:0kB lowmem_reserve[]: 0 0 0 0 Node 1 DMA32 free:256412kB min:30404kB low:38004kB high:45604kB active_anon:337216kB inactive_anon:64kB active_file:8416kB inactive_file:20456kB unevictable:0kB writepending:384kB present:1048560kB managed:755216kB mlocked:0kB kernel_stack:2560kB pagetables:2096kB bounce:0kB free_pcp:1644kB local_pcp:176kB 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 Node 0 DMA32: 219*4kB (UME) 260*8kB (UME) 241*16kB (UME) 128*32kB (UME) 22*64kB (UME) 29*128kB (UME) 40*256kB (UME) 15*512kB (UM) 6*1024kB (UM) 2*2048kB (M) 144*4096kB (UM) = 634012kB Node 1 DMA32: 223*4kB (UME) 655*8kB (UME) 341*16kB (UME) 740*32kB (UME) 634*64kB (UME) 236*128kB (UM) 72*256kB (UM) 10*512kB (UM) 13*1024kB (UM) 2*2048kB (UM) 31*4096kB (UME) = 273988kB 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 8345 total pagecache pages 0 pages in swap cache Swap cache stats: add 0, delete 0, find 0/0 syz-executor6: vmalloc: allocation failure: 17179869180 bytes, mode:0x14080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null) syz-executor6 cpuset=/ mems_allowed=0-1 CPU: 3 PID: 8180 Comm: syz-executor6 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 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:00007f1832b01c08 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 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=8198 comm=syz-executor7 dccp_v6_rcv: dropped packet with invalid checksum QAT: Invalid ioctl dccp_v6_rcv: dropped packet with invalid checksum Free swap = 0kB Total swap = 0kB 524186 pages RAM 0 pages HighMem/MovableOnly 103968 pages reserved