===================================== [ BUG: bad unlock balance detected! ] 4.9.67-gf26d3c7 #106 Not tainted ------------------------------------- syz-executor5/21435 is trying to release lock ([ 131.896512] keychord: keycode 16224 out of range mrt_lock) at: binder: 21433:21449 ioctl 40046205 0 returned -22 binder: 21433:21449 ERROR: BC_REGISTER_LOOPER called without request but there are no more locks to release! other info that might help us debug this: binder: 21449 RLIMIT_NICE not set binder: 21433:21449 got transaction to invalid handle binder: 21433:21449 transaction failed 29201/-22, size 0-8 line 3007 binder: 21433:21449 BC_FREE_BUFFER u0000000000000000 no match binder: 21433:21449 got transaction with invalid data ptr binder: 21433:21449 transaction failed 29201/-14, size 72-8 line 3149 binder: 21433:21449 ioctl c0306201 20005fd0 returned -14 binder: unexpected work type, 4, not freed binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29201 binder: 21433:21449 ioctl c0306201 20004000 returned -14 binder: undelivered TRANSACTION_COMPLETE binder: undelivered transaction 306, process died. 2 locks held by syz-executor5/21435: #0: (&f->f_pos_lock){+.+.+.}, at: [] __fdget_pos+0x9f/0xc0 fs/file.c:781 #1: (&p->lock){+.+.+.}, at: [] seq_read+0xdd/0x1290 fs/seq_file.c:178 stack backtrace: CPU: 0 PID: 21435 Comm: syz-executor5 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801d8c978e8 ffffffff81d906e9 ffffffff849ae8f8 ffff8801c68e1800 ffffffff834dec54 ffffffff849ae8f8 ffff8801c68e2088 ffff8801d8c97918 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 binder: 21433:21449 ioctl 40046205 6 returned -22 binder: 21433:21453 ioctl 40046205 0 returned -22 binder: 21433:21453 ERROR: BC_REGISTER_LOOPER called without request binder: 21433:21453 ioctl c0306201 20008fd0 returned -11 binder: 21433:21449 got transaction to invalid handle binder: 21433:21453 got reply transaction with no transaction stack binder: 21433:21449 transaction failed 29201/-22, size 0-8 line 3007 binder: 21433:21466 BC_FREE_BUFFER u0000000000000000 no match binder: 21433:21466 IncRefs 0 refcount change on invalid ref 1 ret -22 binder: 21433:21466 got transaction to invalid handle binder: 21433:21466 transaction failed 29201/-22, size 72-8 line 3007 binder: 21433:21466 ioctl c0306201 20005fd0 returned -14 binder: 21433:21466 ioctl c0306201 20004000 returned -14 device gre0 entered promiscuous mode binder: 21433:21453 transaction failed 29201/-71, size 24-8 line 2923 binder: undelivered TRANSACTION_ERROR: 29201 binder: undelivered TRANSACTION_ERROR: 29201 loop_reread_partitions: partition scan of loop0 (2°]€fI¸Òæ¶Ì”B±!S,›ùDÏ') failed (rc=-13) loop_reread_partitions: partition scan of loop0 () failed (rc=-13) device gre0 entered promiscuous mode IPv6: Can't replace route, no match found IPv6: Can't replace route, no match found device gre0 entered promiscuous mode binder: 21880:21889 ioctl 40046205 0 returned -22 binder: 21880:21889 ERROR: BC_REGISTER_LOOPER called without request binder: 21889 RLIMIT_NICE not set binder: 21880:21889 unknown command 1400526783 binder: 21880:21889 ioctl c0306201 20002fd0 returned -22 binder: 21880:21889 ioctl c018620b 20000fe8 returned -14 binder: 21880:21889 BC_FREE_BUFFER uffffffffffffffff no match binder: 21880:21889 BC_CLEAR_DEATH_NOTIFICATION death notification not active binder: 21880:21889 BC_REQUEST_DEATH_NOTIFICATION invalid ref 3 binder: 21880:21889 got reply transaction with no transaction stack binder: 21880:21889 transaction failed 29201/-71, size 32-16 line 2923 binder: undelivered TRANSACTION_COMPLETE binder: undelivered transaction 318, process died. binder: 21880:21897 BC_FREE_BUFFER u00000000ffffffff no match binder: 21880:21897 ioctl 40046205 6 returned -22 binder: 21880:21901 ioctl 40046205 0 returned -22 binder: 21880:21889 ioctl c0306201 20005fd0 returned -14 binder: BINDER_SET_CONTEXT_MGR already set binder: 21880:21897 ioctl 40046207 0 returned -16 binder: 21880:21901 ERROR: BC_REGISTER_LOOPER called without request binder_alloc: 21880: binder_alloc_buf, no vma binder: 21880:21897 transaction failed 29189/-3, size 536870912-0 line 3130 binder: 21880:21897 unknown command 1400526783 binder: 21880:21897 ioctl c0306201 20002fd0 returned -22 binder: 21880:21918 ioctl c018620b 20000fe8 returned -14 binder: 21880:21897 BC_FREE_BUFFER uffffffffffffffff no match binder: 21880:21897 IncRefs 0 refcount change on invalid ref 1 ret -22 binder: 21880:21897 got transaction to invalid handle binder: 21880:21897 transaction failed 29201/-22, size 72-8 line 3007 binder: 21880:21897 ioctl c0306201 20005fd0 returned -14 binder: undelivered TRANSACTION_ERROR: 29189 binder: unexpected work type, 4, not freed binder: undelivered TRANSACTION_COMPLETE binder: unexpected work type, 4, not freed binder: undelivered TRANSACTION_COMPLETE binder: undelivered TRANSACTION_ERROR: 29201 binder: undelivered transaction 322, process died. binder: undelivered TRANSACTION_ERROR: 29201 9pnet_virtio: no channels available for device HHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHHH 9pnet_virtio: no channels available for device H FAULT_FLAG_ALLOW_RETRY missing 30 CPU: 0 PID: 22068 Comm: syz-executor5 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801cb87f8e0 ffffffff81d906e9 ffff8801cb87fbc0 0000000000000000 ffff8801cac97d90 ffff8801cb87fab0 ffff8801cac97c80 ffff8801cb87fad8 ffffffff8165e307 ffff8801db221ce8 ffff8801cb87fa30 00000001d1fc9067 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 [] strndup_user+0x28/0xb0 mm/util.c:160 [] SYSC_request_key security/keys/keyctl.c:186 [inline] [] SyS_request_key+0xd6/0x2d0 security/keys/keyctl.c:158 [] entry_SYSCALL_64_fastpath+0x23/0xc6 binder: 22100:22102 DecRefs 0 refcount change on invalid ref 1 ret -22 binder_alloc: 22100: binder_alloc_buf, no vma binder: 22100:22112 transaction failed 29189/-3, size 0-0 line 3130 binder: 22100:22102 DecRefs 0 refcount change on invalid ref 912 ret -22 binder: 22100:22102 unknown command 0 binder: 22100:22102 ioctl c0306201 20003000 returned -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 22100:22112 ioctl 40046207 0 returned -16 binder: BINDER_SET_CONTEXT_MGR already set binder: 22100:22102 ioctl 40046207 0 returned -16 binder: 22100:22102 DecRefs 0 refcount change on invalid ref 1 ret -22 binder_alloc: 22100: binder_alloc_buf, no vma binder: 22100:22112 transaction failed 29189/-3, size 0-0 line 3130 binder: 22100:22150 DecRefs 0 refcount change on invalid ref 912 ret -22 binder: 22100:22150 unknown command 0 binder: 22100:22150 ioctl c0306201 20003000 returned -22 binder: BINDER_SET_CONTEXT_MGR already set binder: 22100:22141 ioctl 40046207 0 returned -16 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 devpts: called with bogus options devpts: called with bogus options PF_BRIDGE: RTM_NEWNEIGH with unknown ifindex PF_BRIDGE: RTM_NEWNEIGH with unknown ifindex device lo entered promiscuous mode device lo left promiscuous mode FAULT_FLAG_ALLOW_RETRY missing 30 CPU: 0 PID: 22271 Comm: syz-executor7 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801ca8ff740 ffffffff81d906e9 ffff8801ca8ffa20 0000000000000000 ffff8801cac97490 ffff8801ca8ff910 ffff8801cac97380 ffff8801ca8ff938 ffffffff8165e307 ffffffff811eec95 ffff8801ca8ff890 00000001cebc2067 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 [] do_fcntl fs/fcntl.c:274 [inline] [] SYSC_fcntl fs/fcntl.c:372 [inline] [] SyS_fcntl+0x8fd/0xc70 fs/fcntl.c:357 [] entry_SYSCALL_64_fastpath+0x23/0xc6 device lo entered promiscuous mode device lo left promiscuous mode device syz3 entered promiscuous mode IPVS: length: 24 != 888 FAULT_FLAG_ALLOW_RETRY missing 30 CPU: 1 PID: 22439 Comm: syz-executor0 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801a58bf4e0 ffffffff81d906e9 ffff8801a58bf7c0 0000000000000000 ffff8801cac96d10 ffff8801a58bf6b0 ffff8801cac96c00 ffff8801a58bf6d8 ffffffff8165e307 ffff880102408040 ffff8801a58bf630 00000001d9908067 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 [] generic_perform_write+0x1dc/0x500 mm/filemap.c:2731 [] __generic_file_write_iter+0x348/0x570 mm/filemap.c:2866 [] generic_file_write_iter+0x2d5/0x600 mm/filemap.c:2894 [] new_sync_write fs/read_write.c:499 [inline] [] __vfs_write+0x4bf/0x680 fs/read_write.c:512 [] vfs_write+0x189/0x530 fs/read_write.c:560 [] SYSC_write fs/read_write.c:607 [inline] [] SyS_write+0xd9/0x1b0 fs/read_write.c:599 [] entry_SYSCALL_64_fastpath+0x23/0xc6 FAULT_FLAG_ALLOW_RETRY missing 30 CPU: 0 PID: 22459 Comm: syz-executor0 Not tainted 4.9.67-gf26d3c7 #106 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 ffff8801d61ff4e0 ffffffff81d906e9 ffff8801d61ff7c0 0000000000000000 ffff8801cfd6b790 ffff8801d61ff6b0 ffff8801cfd6b680 ffff8801d61ff6d8 ffffffff8165e307 ffffffff810d3db6 ffff8801d61ff630 00000001cf3e0067 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 [] generic_perform_write+0x1dc/0x500 mm/filemap.c:2731 [] __generic_file_write_iter+0x348/0x570 mm/filemap.c:2866 [] generic_file_write_iter+0x2d5/0x600 mm/filemap.c:2894 [] new_sync_write fs/read_write.c:499 [inline] [] __vfs_write+0x4bf/0x680 fs/read_write.c:512 [] vfs_write+0x189/0x530 fs/read_write.c:560 [] SYSC_write fs/read_write.c:607 [inline] [] SyS_write+0xd9/0x1b0 fs/read_write.c:599 [] entry_SYSCALL_64_fastpath+0x23/0xc6 SELinux: unrecognized netlink message: protocol=0 nlmsg_type=31526 sclass=netlink_route_socket pig=22550 comm=syz-executor0 loop_reread_partitions: partition scan of loop0 (2°]€fI¸Òæ¶Ì”B±!S,›ùDÏ') failed (rc=-13) device gre0 entered promiscuous mode IPVS: Creating netns size=2536 id=35 Can not set IPV6_FL_F_REFLECT if flowlabel_consistency sysctl is enable Can not set IPV6_FL_F_REFLECT if flowlabel_consistency sysctl is enable SELinux: unrecognized netlink message: protocol=0 nlmsg_type=31526 sclass=netlink_route_socket pig=22583 comm=syz-executor0 loop_reread_partitions: partition scan of loop0 () failed (rc=-13) 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: 22717:22728 ERROR: BC_REGISTER_LOOPER called without request binder: 22717:22728 ERROR: BC_REGISTER_LOOPER called without request binder: 22717:22728 DecRefs 0 refcount change on invalid ref 3 ret -22 binder: 22717:22728 DecRefs 0 refcount change on invalid ref 1 ret -22 binder: 22717:22728 ERROR: BC_REGISTER_LOOPER called without request SELinux: unrecognized netlink message: protocol=0 nlmsg_type=0 sclass=netlink_route_socket pig=22742 comm=syz-executor4 binder: 22717:22728 got reply transaction with no transaction stack binder: 22717:22728 transaction failed 29201/-71, size 0-0 line 2923