===================================== netlink: 8 bytes leftover after parsing attributes in process `syz-executor4'. [ BUG: bad unlock balance detected! ] 4.9.67-gf26d3c7 #106 Not tainted ------------------------------------- syz-executor2/11607 is trying to release lock ([ 72.400260] netlink: 8 bytes leftover after parsing attributes in process `syz-executor4'. mrt_lock) at: but there are no more locks to release! other info that might help us debug this: 1 lock held by syz-executor2/11607: #0: (&p->lock){+.+.+.}, at: [] seq_read+0xdd/0x1290 fs/seq_file.c:178 stack backtrace: CPU: 1 PID: 11607 Comm: syz-executor2 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801a15378e8 ffffffff81d906e9 ffffffff849ae8f8 ffff8801d21c1800 ffffffff834dec54 ffffffff849ae8f8 ffff8801d21c2088 ffff8801a1537918 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 TCP: request_sock_TCP: Possible SYN flooding on port 20030. Sending cookies. Check SNMP counters. binder: 11694:11695 ERROR: BC_REGISTER_LOOPER called without request binder: BINDER_SET_CONTEXT_MGR already set binder: 11694:11716 ioctl 40046207 0 returned -16 binder: 11694:11702 ERROR: BC_REGISTER_LOOPER called without request binder: 11745:11746 ERROR: BC_REGISTER_LOOPER called without request binder: release 11745:11746 transaction 122 in, still active binder: send failed reply for transaction 122 to 11745:11767 binder: BINDER_SET_CONTEXT_MGR already set binder: 11745:11767 ioctl 40046207 0 returned -16 binder: 11745:11746 ERROR: BC_REGISTER_LOOPER called without request binder_alloc: 11745: binder_alloc_buf, no vma binder: 11745:11767 transaction failed 29189/-3, size 0-0 line 3130 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29189 keychord: invalid keycode count 0 keychord: invalid keycode count 0 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=0 sclass=netlink_xfrm_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=0 sclass=netlink_xfrm_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=202 sclass=netlink_route_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=0 sclass=netlink_xfrm_socket pig=11909 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11914 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=11914 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=6 nlmsg_type=0 sclass=netlink_xfrm_socket pig=11914 comm=syz-executor6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=202 sclass=netlink_route_socket pig=11912 comm=syz-executor6 sg_write: data in/out 760718663/119 bytes for SCSI command 0xa2-- guessing data in; program syz-executor2 not setting count and/or reply_len properly binder: BINDER_SET_CONTEXT_MGR already set binder: 11979:11985 ioctl 40046207 0 returned -16 binder_alloc: 11979: binder_alloc_buf, no vma binder: 11979:11985 transaction failed 29189/-3, size 0-0 line 3130 device lo entered promiscuous mode binder: undelivered TRANSACTION_ERROR: 29189 binder: release 11979:11980 transaction 126 out, still active binder: release 11979:11980 transaction 125 in, still active binder: undelivered TRANSACTION_COMPLETE binder: send failed reply for transaction 126, target dead binder: send failed reply for transaction 125 to 11979:11980 binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29189 device lo left promiscuous mode device lo entered promiscuous mode device gre0 entered promiscuous mode IPVS: Creating netns size=2536 id=18 sg_write: data in/out 327644/32 bytes for SCSI command 0x4-- guessing data in; program syz-executor7 not setting count and/or reply_len properly 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 nla_parse: 14 callbacks suppressed netlink: 5 bytes leftover after parsing attributes in process `syz-executor3'. ƒ: renamed from lo netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor3'. IPVS: Creating netns size=2536 id=19 netlink: 3 bytes leftover after parsing attributes in process `syz-executor4'. device gre0 entered promiscuous mode 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 device syz0 entered promiscuous mode keychord: invalid keycode count 0 keychord: invalid keycode count 0 binder: 12648:12649 ioctl 40046205 0 returned -22 binder: 12648:12649 ERROR: BC_REGISTER_LOOPER called without request binder: 12648:12649 unknown command 1400526783 binder: 12648:12649 ioctl c0306201 20002fd0 returned -22 binder: 12648:12649 got transaction with invalid offset (48, min 0 max 112) or object. binder: 12648:12649 transaction failed 29201/-22, size 112-64 line 3193 binder: 12648:12649 ioctl c0306201 20005fd0 returned -14 binder: unexpected work type, 4, not freed binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29201 binder: 12648:12649 BC_FREE_BUFFER u00000000ffffffff no match binder: undelivered TRANSACTION_COMPLETE binder: 12648:12649 ioctl 40046205 6 returned -22 binder: 12648:12663 ioctl 40046205 0 returned -22 binder: undelivered transaction 130, process died. binder: 12648:12663 ERROR: BC_REGISTER_LOOPER called without request binder: 12648:12663 ioctl c0306201 20008fd0 returned -11 binder: 12648:12649 unknown command 1400526783 binder: 12648:12649 ioctl c0306201 20002fd0 returned -22 binder: 12648:12663 got reply transaction with no transaction stack binder: 12648:12663 transaction failed 29201/-71, size 24-8 line 2923 binder: 12648:12663 got transaction to invalid handle binder: 12648:12663 transaction failed 29201/-22, size 112-64 line 3007 binder: 12648:12663 ioctl c0306201 20005fd0 returned -14 binder: undelivered TRANSACTION_ERROR: 29201 binder: release 12648:12649 transaction 135 out, still active binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29201 binder: send failed reply for transaction 135, target dead device gre0 entered promiscuous mode netlink: 3 bytes leftover after parsing attributes in process `syz-executor0'. netlink: 3 bytes leftover after parsing attributes in process `syz-executor0'. device gre0 entered promiscuous mode FAULT_FLAG_ALLOW_RETRY missing 30 FAULT_FLAG_ALLOW_RETRY missing 30 CPU: 1 PID: 12835 Comm: syz-executor5 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801c79cf8c0 ffffffff81d906e9 ffff8801c79cfba0 0000000000000000 ffff8801c7eaea10 ffff8801c79cfa90 ffff8801c7eae900 ffff8801c79cfab8 ffffffff8165e307 0000000000000000 ffff8801c79cfa10 00000001c50ea067 Call Trace: [] __dump_stack lib/dump_stack.c:15 [inline] [] dump_stack+0xc1/0x128 lib/dump_stack.c:51 [] handle_userfault+0xa37/0x1300 fs/userfaultfd.c:323 [] do_anonymous_page mm/memory.c:2747 [inline] [] handle_pte_fault mm/memory.c:3488 [inline] [] __handle_mm_fault mm/memory.c:3577 [inline] [] handle_mm_fault+0x1fd1/0x2530 mm/memory.c:3614 [] __do_page_fault+0x5c2/0xd40 arch/x86/mm/fault.c:1406 [] do_page_fault+0x27/0x30 arch/x86/mm/fault.c:1469 [] page_fault+0x28/0x30 arch/x86/entry/entry_64.S:1012 [] entry_SYSCALL_64_fastpath+0x23/0xc6 binder: 12872:12873 BC_FREE_BUFFER u0000000000000000 no match binder: 12872:12873 BC_DEAD_BINDER_DONE 0000000000000004 not found binder: 12872:12873 ERROR: BC_REGISTER_LOOPER called after BC_ENTER_LOOPER binder: 12872:12873 BC_CLEAR_DEATH_NOTIFICATION invalid ref 2 binder: 12872:12873 got reply transaction with no transaction stack binder: 12872:12873 transaction failed 29201/-71, size 72-40 line 2923 binder: 12872:12873 DecRefs 0 refcount change on invalid ref 2 ret -22 binder: 12872:12873 BC_REQUEST_DEATH_NOTIFICATION death notification already set binder: 12872:12877 BC_DEAD_BINDER_DONE 0000000000000003 not found binder: 12872 invalid dec weak, ref 139 desc 0 s 1 w 0 binder: 12872:12877 DecRefs 0 refcount change on invalid ref 4 ret -22 binder: 12872:12877 BC_CLEAR_DEATH_NOTIFICATION death notification cookie mismatch 0000000000000003 != fffffffffffffffe binder: 12872:12877 got reply transaction with no transaction stack binder: 12872:12877 transaction failed 29201/-71, size 0-48 line 2923 binder: BINDER_SET_CONTEXT_MGR already set binder: 12872:12883 ioctl 40046207 0 returned -16 binder: 12872:12883 BC_REQUEST_DEATH_NOTIFICATION death notification already set binder: 12872:12877 BC_CLEAR_DEATH_NOTIFICATION death notification cookie mismatch 0000000000000003 != 0000000000000000 binder: 12872:12885 unknown command 0 binder: 12872:12885 ioctl c0306201 2000a000 returned -22 binder: 12872:12885 unknown command 0 binder: 12872:12885 ioctl c0306201 20003fd0 returned -22 CPU: 0 PID: 12848 Comm: syz-executor5 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801c60b78c0 ffffffff81d906e9 ffff8801c60b7ba0 0000000000000000 ffff8801c7eaea10 ffff8801c60b7a90 ffff8801c7eae900 ffff8801c60b7ab8 ffffffff8165e307 0000000000000000 ffff8801c60b7a10 00000001c50ea067 Call Trace: [] __dump_stack lib/dump_stack.c:15 [inline] [] dump_stack+0xc1/0x128 lib/dump_stack.c:51 [] handle_userfault+0xa37/0x1300 fs/userfaultfd.c:323 [] do_anonymous_page mm/memory.c:2747 [inline] [] handle_pte_fault mm/memory.c:3488 [inline] [] __handle_mm_fault mm/memory.c:3577 [inline] [] handle_mm_fault+0x1fd1/0x2530 mm/memory.c:3614 [] __do_page_fault+0x5c2/0xd40 arch/x86/mm/fault.c:1406 [] do_page_fault+0x27/0x30 arch/x86/mm/fault.c:1469 [] page_fault+0x28/0x30 arch/x86/entry/entry_64.S:1012 [] entry_SYSCALL_64_fastpath+0x23/0xc6 device gre0 entered promiscuous mode blk_update_request: 7 callbacks suppressed blk_update_request: I/O error, dev loop7, sector 0 buffer_io_error: 7 callbacks suppressed Buffer I/O error on dev loop7, logical block 0, lost async page write blk_update_request: I/O error, dev loop7, sector 8 Buffer I/O error on dev loop7, logical block 1, lost async page write blk_update_request: I/O error, dev loop7, sector 16 Buffer I/O error on dev loop7, logical block 2, lost async page write blk_update_request: I/O error, dev loop7, sector 24 Buffer I/O error on dev loop7, logical block 3, lost async page write blk_update_request: I/O error, dev loop7, sector 32 Buffer I/O error on dev loop7, logical block 4, lost async page write blk_update_request: I/O error, dev loop7, sector 40 Buffer I/O error on dev loop7, logical block 5, lost async page write blk_update_request: I/O error, dev loop7, sector 48 Buffer I/O error on dev loop7, logical block 6, lost async page write blk_update_request: I/O error, dev loop7, sector 56 Buffer I/O error on dev loop7, logical block 7, lost async page write blk_update_request: I/O error, dev loop7, sector 64 Buffer I/O error on dev loop7, logical block 8, lost async page write blk_update_request: I/O error, dev loop7, sector 72 Buffer I/O error on dev loop7, logical block 9, lost async page write device gre0 entered promiscuous mode netlink: 5 bytes leftover after parsing attributes in process `syz-executor7'. netlink: 5 bytes leftover after parsing attributes in process `syz-executor7'. binder: 13042:13047 ERROR: BC_REGISTER_LOOPER called without request binder: BINDER_SET_CONTEXT_MGR already set binder: 13042:13072 ERROR: BC_REGISTER_LOOPER called without request binder: 13042:13066 ioctl 40046207 0 returned -16 netlink: 7 bytes leftover after parsing attributes in process `syz-executor6'. binder: 13100:13101 got transaction to invalid handle binder: 13100:13101 transaction failed 29201/-22, size 0-0 line 3007 binder: 13100:13102 got transaction to invalid handle binder: 13100:13102 transaction failed 29201/-22, size 0-0 line 3007 binder: undelivered TRANSACTION_ERROR: 29201 binder: undelivered TRANSACTION_ERROR: 29201 netlink: 7 bytes leftover after parsing attributes in process `syz-executor6'. 9pnet_virtio: no channels available for device H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H 9pnet_virtio: no channels available for device H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H¨H