===================================== [ BUG: bad unlock balance detected! ] 4.9.67-gf26d3c7 #106 Not tainted ------------------------------------- syz-executor6/23746 is trying to release lock (mrt_lock[ 174.330977] netlink: 8 bytes leftover after parsing attributes in process `syz-executor2'. ) at: but there are no more locks to release! other info that might help us debug this: 1 lock held by syz-executor6/23746: #0: (&p->lock){+.+.+.}, at: [] seq_read+0xdd/0x1290 fs/seq_file.c:178 stack backtrace: CPU: 0 PID: 23746 Comm: syz-executor6 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801d1b578e8 ffffffff81d906e9 ffffffff849ae8f8 ffff8801d98be000 ffffffff834dec54 ffffffff849ae8f8 ffff8801d98be888 ffff8801d1b57918 ffffffff812353f4 dffffc0000000000 ffffffff849ae8f8 00000000ffffffff Call Trace: [] __dump_stack lib/dump_stack.c:15 [inline] [] dump_stack+0xc1/0x128 lib/dump_stack.c:51 [] print_unlock_imbalance_bug+0x174/0x1a0 kernel/locking/lockdep.c:3398 [] __lock_release kernel/locking/lockdep.c:3540 [inline] [] lock_release+0x6f8/0xb80 kernel/locking/lockdep.c:3775 [] __raw_read_unlock include/linux/rwlock_api_smp.h:225 [inline] [] _raw_read_unlock+0x1a/0x50 kernel/locking/spinlock.c:255 [] ipmr_mfc_seq_stop+0xe4/0x140 net/ipv6/ip6mr.c:553 [] seq_read+0xa83/0x1290 fs/seq_file.c:283 [] proc_reg_read+0xef/0x170 fs/proc/inode.c:202 [] do_loop_readv_writev.part.17+0x141/0x1e0 fs/read_write.c:714 [] do_loop_readv_writev fs/read_write.c:880 [inline] [] do_readv_writev+0x520/0x750 fs/read_write.c:874 [] vfs_readv+0x84/0xc0 fs/read_write.c:898 [] do_readv+0xe6/0x250 fs/read_write.c:924 [] SYSC_readv fs/read_write.c:1011 [inline] [] SyS_readv+0x27/0x30 fs/read_write.c:1008 [] entry_SYSCALL_64_fastpath+0x23/0xc6 netlink: 1 bytes leftover after parsing attributes in process `syz-executor7'. sg_write: data in/out 327644/32 bytes for SCSI command 0x4-- guessing data in; program syz-executor5 not setting count and/or reply_len properly keychord: invalid keycode count 0 keychord: invalid keycode count 0 nla_parse: 1 callbacks suppressed netlink: 6 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 6 bytes leftover after parsing attributes in process `syz-executor4'. qtaguid: iface_stat: create(lo): no inet dev qtaguid: iface_stat: create6(lo): no inet dev IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready qtaguid: iface_stat: create6(lo): no inet dev IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready qtaguid: iface_stat: create6(lo): no inet dev netlink: 5 bytes leftover after parsing attributes in process `syz-executor3'. netlink: 8 bytes leftover after parsing attributes in process `syz-executor3'. devpts: called with bogus options netlink: 5 bytes leftover after parsing attributes in process `syz-executor3'. device lo entered promiscuous mode device lo left promiscuous mode devpts: called with bogus options device lo entered promiscuous mode device lo left promiscuous mode device lo left promiscuous mode device gre0 entered promiscuous mode netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 1 bytes leftover after parsing attributes in process `syz-executor0'. device syz1 entered promiscuous mode device gre0 entered promiscuous mode sg_write: data in/out 901092476/192 bytes for SCSI command 0x1b-- guessing data in; program syz-executor6 not setting count and/or reply_len properly device lo entered promiscuous mode device lo left promiscuous mode binder: 24345:24347 got transaction to invalid handle binder: 24345:24347 transaction failed 29201/-22, size 24-0 line 3007 binder: 24345:24347 ioctl c0306201 2000bfd0 returned -14 binder: 24345:24356 unknown command 0 binder: 24345:24356 ioctl c0306201 2000bfd0 returned -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 24345:24347 ioctl 40046207 0 returned -16 binder: undelivered TRANSACTION_ERROR: 29201 binder: send failed reply for transaction 331 to 24345:24347 binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29189 device lo entered promiscuous mode device lo left promiscuous mode IPv6: Can't replace route, no match found netlink: 3 bytes leftover after parsing attributes in process `syz-executor6'. IPv6: Can't replace route, no match found netlink: 3 bytes leftover after parsing attributes in process `syz-executor6'. device lo entered promiscuous mode device lo left promiscuous mode device lo entered promiscuous mode device lo left promiscuous mode device gre0 entered promiscuous mode netlink: 5 bytes leftover after parsing attributes in process `syz-executor1'. device gre0 entered promiscuous mode binder: 24575:24577 ioctl 40046205 ffffffffffffff89 returned -22 binder: 24575:24577 Release 1 refcount change on invalid ref 4 ret -22 binder: 24575:24577 BC_INCREFS_DONE u0000000000000000 node 332 cookie mismatch 0000000000000004 != 0000000000000000 binder: 24575:24577 DecRefs 0 refcount change on invalid ref 0 ret -22 binder: 24575:24577 unknown command 0 binder: 24575:24577 ioctl c0306201 20000000 returned -22 binder: 24575:24577 ioctl 40046205 ffffffffffffff89 returned -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 24575:24591 ioctl 40046207 0 returned -16 binder: 24575:24591 unknown command 0 binder: 24575:24591 ioctl c0306201 20000000 returned -22 binder: 24575:24591 ioctl c0306201 20001000 returned -11 binder: release 24618:24623 transaction 334 out, still active binder: undelivered TRANSACTION_COMPLETE device gre0 entered promiscuous mode binder: BINDER_SET_CONTEXT_MGR already set binder: 24618:24623 ioctl 40046207 0 returned -16 binder_alloc: 24618: binder_alloc_buf, no vma binder: 24618:24623 transaction failed 29189/-3, size 0-0 line 3130 binder: undelivered TRANSACTION_ERROR: 29189 binder_alloc: 24618: binder_alloc_buf, no vma binder: 24618:24627 transaction failed 29189/-3, size 0-0 line 3130 binder: undelivered TRANSACTION_ERROR: 29189 binder: release 24618:24623 transaction 335 out, still active binder: release 24618:24623 transaction 334 in, still active binder: undelivered TRANSACTION_COMPLETE binder: send failed reply for transaction 335, target dead binder: send failed reply for transaction 334, target dead binder: 24702:24704 ioctl 40046205 ffffffffffffff89 returned -22 binder: 24702:24704 Release 1 refcount change on invalid ref 4 ret -22 binder: 24702:24704 DecRefs 0 refcount change on invalid ref 0 ret -22 binder: 24702:24704 unknown command 0 binder: 24702:24716 ioctl c0306201 20003fd0 returned -14 binder: 24702:24704 ioctl c0306201 20000fd0 returned -22 binder: 24702:24704 ioctl 40046205 ffffffffffffff89 returned -22 binder: 24702:24704 unknown command 11014 binder: 24702:24716 ioctl c0306201 20001000 returned -11 binder: 24702:24704 ioctl c0306201 20000fd0 returned -22 IPVS: Creating netns size=2536 id=33 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=24774 comm=syz-executor0 pktgen: kernel_thread() failed for cpu 0 pktgen: Cannot create thread for cpu 0 (-4) pktgen: kernel_thread() failed for cpu 1 pktgen: Cannot create thread for cpu 1 (-4) pktgen: Initialization failed for all threads binder: 24896:24897 got transaction to invalid handle binder: 24896:24897 transaction failed 29201/-22, size 0-0 line 3007 binder: 24896:24911 got transaction to invalid handle binder: 24896:24911 transaction failed 29201/-22, size 0-0 line 3007 binder: undelivered TRANSACTION_ERROR: 29201 binder: undelivered TRANSACTION_ERROR: 29201 device gre0 entered promiscuous mode binder: 25057:25064 Release 1 refcount change on invalid ref 2 ret -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 25057:25075 Release 1 refcount change on invalid ref 2 ret -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 25057:25075 ioctl 40046207 0 returned -16 binder: 25057:25064 ioctl 40046207 0 returned -16 device lo entered promiscuous mode IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready device gre0 entered promiscuous mode IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready IPv6: ADDRCONF(NETDEV_CHANGE): lo: link becomes ready binder: 25367:25368 not enough space to store 0 fds in buffer binder: 25367:25368 transaction failed 29201/-22, size 72-32 line 3272 binder_alloc: binder_alloc_mmap_handler: 25367 20000000-20002000 already mapped failed -16 binder_alloc: 25367: binder_alloc_buf, no vma binder: BINDER_SET_CONTEXT_MGR already set binder: 25367:25368 ioctl 40046207 0 returned -16 binder: 25367:25386 transaction failed 29189/-3, size 72-32 line 3130 binder: 25441:25442 ioctl 85 20416000 returned -22 binder: 25441:25442 IncRefs 0 refcount change on invalid ref 2 ret -22 binder: 25441:25442 Acquire 1 refcount change on invalid ref 4 ret -22 binder: 25441:25442 unknown command 0 binder: 25441:25442 ioctl c0306201 20000fd0 returned -22 binder: 25441:25455 ioctl 85 20416000 returned -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 25441:25455 ioctl 40046207 0 returned -16 binder: 25441:25442 IncRefs 0 refcount change on invalid ref 2 ret -22 binder: 25441:25442 Acquire 1 refcount change on invalid ref 4 ret -22 binder: 25441:25442 unknown command 0 binder: 25441:25442 ioctl c0306201 20000fd0 returned -22