PPPIOCDETACH file->f_count=3 ===================================== WARNING: bad unlock balance detected! 4.16.0-rc2+ #323 Not tainted ------------------------------------- syz-executor0/5441 is trying to release lock (rcu_read_lock_bh) at: [] rcu_read_unlock_bh include/linux/rcupdate.h:722 [inline] [] hashlimit_mt_common.isra.10+0x1beb/0x2610 net/netfilter/xt_hashlimit.c:777 but there are no more locks to release! other info that might help us debug this: 3 locks held by syz-executor0/5441: #0: (sk_lock-AF_INET6){+.+.}, at: [<0000000095a39bee>] lock_sock include/net/sock.h:1463 [inline] #0: (sk_lock-AF_INET6){+.+.}, at: [<0000000095a39bee>] sctp_sendmsg+0xc1e/0x35e0 net/sctp/socket.c:1723 #1: (rcu_read_lock){....}, at: [<0000000071fa3569>] sctp_v6_xmit+0x2e5/0x630 net/sctp/ipv6.c:222 #2: (rcu_read_lock){....}, at: [<000000006ef21d7f>] ip6_autoflowlabel net/ipv6/ip6_output.c:291 [inline] #2: (rcu_read_lock){....}, at: [<000000006ef21d7f>] ip6_xmit+0xe9d/0x2260 net/ipv6/ip6_output.c:249 stack backtrace: CPU: 1 PID: 5441 Comm: syz-executor0 Not tainted 4.16.0-rc2+ #323 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x194/0x257 lib/dump_stack.c:53 print_unlock_imbalance_bug+0x12f/0x140 kernel/locking/lockdep.c:3484 __lock_release kernel/locking/lockdep.c:3691 [inline] lock_release+0x6fe/0xa40 kernel/locking/lockdep.c:3939 rcu_lock_release include/linux/rcupdate.h:249 [inline] rcu_read_unlock_bh include/linux/rcupdate.h:724 [inline] hashlimit_mt_common.isra.10+0x1c08/0x2610 net/netfilter/xt_hashlimit.c:777 hashlimit_mt+0x78/0x90 net/netfilter/xt_hashlimit.c:846 ip6t_do_table+0x98d/0x1a30 net/ipv6/netfilter/ip6_tables.c:319 ip6table_filter_hook+0x65/0x80 net/ipv6/netfilter/ip6table_filter.c:41 nf_hook_entry_hookfn include/linux/netfilter.h:120 [inline] nf_hook_slow+0xba/0x1a0 net/netfilter/core.c:483 nf_hook include/linux/netfilter.h:243 [inline] NF_HOOK include/linux/netfilter.h:286 [inline] ip6_xmit+0x10ec/0x2260 net/ipv6/ip6_output.c:277 sctp_v6_xmit+0x438/0x630 net/sctp/ipv6.c:225 sctp_packet_transmit+0x225e/0x3750 net/sctp/output.c:638 sctp_outq_flush+0xabb/0x4060 net/sctp/outqueue.c:911 sctp_outq_uncork+0x5a/0x70 net/sctp/outqueue.c:776 sctp_cmd_interpreter net/sctp/sm_sideeffect.c:1807 [inline] sctp_side_effects net/sctp/sm_sideeffect.c:1210 [inline] sctp_do_sm+0x4e0/0x6ed0 net/sctp/sm_sideeffect.c:1181 sctp_primitive_ASSOCIATE+0x9d/0xd0 net/sctp/primitive.c:88 sctp_sendmsg+0x13bd/0x35e0 net/sctp/socket.c:1985 inet_sendmsg+0x11f/0x5e0 net/ipv4/af_inet.c:764 sock_sendmsg_nosec net/socket.c:630 [inline] sock_sendmsg+0xca/0x110 net/socket.c:640 SYSC_sendto+0x361/0x5c0 net/socket.c:1747 SyS_sendto+0x40/0x50 net/socket.c:1715 do_syscall_64+0x280/0x940 arch/x86/entry/common.c:287 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x453da9 RSP: 002b:00007f3424ec0c68 EFLAGS: 00000246 ORIG_RAX: 000000000000002c RAX: ffffffffffffffda RBX: 00007f3424ec16d4 RCX: 0000000000453da9 RDX: 0000000000000001 RSI: 00000000203aa000 RDI: 0000000000000013 RBP: 000000000072bf58 R08: 0000000020749fe4 R09: 000000000000001c R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000000004ba R14: 00000000006f7210 R15: 0000000000000001 PPPIOCDETACH file->f_count=2 audit: type=1400 audit(1519215300.105:23): avc: denied { map } for pid=5456 comm="syz-executor4" path="/dev/vcs" dev="devtmpfs" ino=1042 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:tty_device_t:s0 tclass=chr_file permissive=1 audit: type=1401 audit(1519215300.199:24): op=security_bounded_transition seresult=denied oldcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 newcontext=system_u:object_r:init_var_run_t:s0 binder: 5507:5509 transaction failed 29189/-22, size 0-0 line 2842 audit: type=1400 audit(1519215300.297:25): avc: denied { map } for pid=5507 comm="syz-executor1" path="/dev/binder0" dev="devtmpfs" ino=9056 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:device_t:s0 tclass=chr_file permissive=1 binder: 5507:5514 got transaction to invalid handle binder: 5507:5514 transaction failed 29201/-22, size 0-0 line 2842 binder: 5507:5509 transaction failed 29189/-22, size 0-0 line 2842 binder: undelivered TRANSACTION_ERROR: 29189 audit: type=1400 audit(1519215300.865:26): avc: denied { map_read map_write } for pid=5519 comm="syz-executor3" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=bpf permissive=1 audit: type=1400 audit(1519215300.924:27): avc: denied { prog_run } for pid=5519 comm="syz-executor3" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=bpf permissive=1 audit: type=1400 audit(1519215301.499:28): avc: denied { name_connect } for pid=5560 comm="syz-executor5" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:port_t:s0 tclass=dccp_socket permissive=1 netlink: 8 bytes leftover after parsing attributes in process `syz-executor5'. netlink: 8 bytes leftover after parsing attributes in process `syz-executor5'. binder: BINDER_SET_CONTEXT_MGR already set binder: 5784:5799 ioctl 40046207 0 returned -16 binder_alloc: 5784: binder_alloc_buf, no vma binder: 5784:5791 transaction failed 29189/-3, size 0-0 line 2957 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_COMPLETE binder: undelivered transaction 5, process died. binder: BINDER_SET_CONTEXT_MGR already set sctp: [Deprecated]: syz-executor7 (pid 5932) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead binder: 5901:5933 ioctl 40046207 0 returned -16 sctp: [Deprecated]: syz-executor7 (pid 5942) Use of struct sctp_assoc_value in delayed_ack socket option. Use struct sctp_sack_info instead capability: warning: `syz-executor6' uses 32-bit capabilities (legacy support in use) mmap: syz-executor4 (5968) uses deprecated remap_file_pages() syscall. See Documentation/vm/remap_file_pages.txt. pit: kvm: requested 5866 ns i8254 timer period limited to 500000 ns netlink: 2 bytes leftover after parsing attributes in process `syz-executor5'. netlink: 2 bytes leftover after parsing attributes in process `syz-executor5'. kauditd_printk_skb: 18 callbacks suppressed audit: type=1400 audit(1519215303.060:47): avc: denied { getopt } for pid=6049 comm="syz-executor2" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_netfilter_socket permissive=1 audit: type=1400 audit(1519215303.060:48): avc: denied { send } for pid=6049 comm="syz-executor2" saddr=fe80::a8aa:aaff:feaa:20c src=36550 daddr=ff01::1 netif=wlan0 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:udev_var_run_t:s0 tclass=packet permissive=1 audit: type=1400 audit(1519215303.061:49): avc: denied { send } for pid=6049 comm="syz-executor2" saddr=fe80::a8aa:aaff:feaa:20c src=36550 daddr=ff01::1 netif=wlan0 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:udev_var_run_t:s0 tclass=packet permissive=1 netlink: 'syz-executor3': attribute type 1 has an invalid length. netlink: 'syz-executor3': attribute type 26 has an invalid length. netlink: 'syz-executor3': attribute type 26 has an invalid length. netlink: 'syz-executor3': attribute type 1 has an invalid length. netlink: 'syz-executor3': attribute type 1 has an invalid length. netlink: 'syz-executor3': attribute type 1 has an invalid length. netlink: 'syz-executor3': attribute type 1 has an invalid length. netlink: 'syz-executor3': attribute type 26 has an invalid length. netlink: 'syz-executor3': attribute type 26 has an invalid length. netlink: 'syz-executor3': attribute type 1 has an invalid length. kvm [6099]: vcpu0, guest rIP: 0xfff0 Hyper-V uhandled wrmsr: 0x4000006c data 0x0 binder: 6138:6141 ioctl c0306201 20008000 returned -14 binder_alloc: binder_alloc_mmap_handler: 6138 20000000-20002000 already mapped failed -16 binder: 6138:6141 ioctl c0306201 20008000 returned -14 xt_connbytes: Forcing CT accounting to be enabled x_tables: ip_tables: socket match: used from hooks INPUT/FORWARD/OUTPUT, but only valid from PREROUTING/INPUT x_tables: ip_tables: socket match: used from hooks INPUT/FORWARD/OUTPUT, but only valid from PREROUTING/INPUT openvswitch: netlink: Flow key attr not present in new flow. openvswitch: netlink: Flow key attr not present in new flow. binder: 6573:6576 ioctl 80184540 20000040 returned -22 binder: 6573:6576 ioctl 80104592 20000200 returned -22 audit: type=1400 audit(1519215305.232:50): avc: denied { transfer } for pid=6573 comm="syz-executor6" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=binder permissive=1 binder: release 6573:6576 transaction 9 out, still active binder: unexpected work type, 4, not freed IPVS: ftp: loaded support on port[0] = 21 binder: undelivered TRANSACTION_COMPLETE binder: 6573:6576 ioctl 8904 20000240 returned -22 binder: invalid inc weak node for 10 binder: 6573:6576 IncRefs 0 refcount change on invalid ref 1 ret -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 6573:6576 ioctl 40046207 0 returned -16 binder: 6573:6582 ioctl 80184540 20000040 returned -22 binder: 6573:6584 ioctl 80104592 20000200 returned -22 binder_alloc: 6573: binder_alloc_buf, no vma binder: 6573:6576 ioctl 8904 20000240 returned -22 binder: 6573:6584 transaction failed 29189/-3, size 40-8 line 2957 binder: undelivered TRANSACTION_ERROR: 29189 binder: send failed reply for transaction 9, target dead IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready device eql entered promiscuous mode rfkill: input handler disabled rfkill: input handler enabled ip6t_REJECT: ECHOREPLY is not supported. ip6t_REJECT: ECHOREPLY is not supported. RDS: rds_bind could not find a transport for 172.20.0.0, load rds_tcp or rds_rdma? audit: type=1400 audit(1519215307.251:51): avc: denied { recv } for pid=7126 comm="syz-executor5" saddr=::1 daddr=::1 dest=48930 netif=lo scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:udev_var_run_t:s0 tclass=packet permissive=1 Cannot find add_set index 0 as target audit: type=1400 audit(1519215307.395:52): avc: denied { setuid } for pid=7174 comm="syz-executor7" capability=7 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=cap_userns permissive=1 audit: type=1400 audit(1519215307.460:53): avc: denied { map } for pid=7196 comm="syz-executor2" path="socket:[20458]" dev="sockfs" ino=20458 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=udp_socket permissive=1 binder: 7225:7232 ioctl c0306201 20008fd0 returned -11 binder: BINDER_SET_CONTEXT_MGR already set binder: 7225:7232 ioctl 40046207 0 returned -16 audit: type=1326 audit(1519215307.698:54): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 pid=7249 comm="syz-executor2" exe="/root/syz-executor2" sig=31 arch=c000003e syscall=202 compat=0 ip=0x453da9 code=0x0 audit: type=1326 audit(1519215307.723:55): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 pid=7249 comm="syz-executor2" exe="/root/syz-executor2" sig=31 arch=c000003e syscall=202 compat=0 ip=0x453da9 code=0x0 audit: type=1400 audit(1519215307.797:56): avc: denied { accept } for pid=7284 comm="syz-executor0" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_netfilter_socket permissive=1 audit: type=1400 audit(1519215308.379:57): avc: denied { setattr } for pid=7339 comm="syz-executor3" name="NETLINK" dev="sockfs" ino=21701 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_generic_socket permissive=1 binder: 7361:7362 got reply transaction with no transaction stack binder: 7361:7362 transaction failed 29201/-71, size 0-16 line 2757 binder: 7361:7375 got reply transaction with no transaction stack binder: 7361:7375 transaction failed 29201/-71, size 0-16 line 2757 binder: undelivered TRANSACTION_ERROR: 29201 binder: undelivered TRANSACTION_ERROR: 29201 audit: type=1400 audit(1519215308.800:58): avc: denied { setgid } for pid=7438 comm="syz-executor7" capability=6 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=cap_userns permissive=1 device eql entered promiscuous mode