audit: type=1400 audit(1574684395.238:2582): avc: denied { prog_load } for pid=25786 comm="syz-executor.5" 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 ====================================================== [ INFO: possible circular locking dependency detected ] 4.9.203-syzkaller #0 Not tainted ------------------------------------------------------- syz-executor.5/25788 is trying to acquire lock: (&mm->mmap_sem){++++++}, at: [<000000006652e125>] __do_page_fault+0x7bd/0xa60 arch/x86/mm/fault.c:1337 but task is already holding lock: (&sb->s_type->i_mutex_key#10){+.+.+.}, at: [<00000000664eaf70>] inode_lock include/linux/fs.h:771 [inline] (&sb->s_type->i_mutex_key#10){+.+.+.}, at: [<00000000664eaf70>] generic_file_write_iter+0x9a/0x630 mm/filemap.c:3090 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: lock_acquire+0x133/0x3d0 kernel/locking/lockdep.c:3759 down_write+0x41/0xa0 kernel/locking/rwsem.c:52 inode_lock include/linux/fs.h:771 [inline] shmem_fallocate+0x143/0xab0 mm/shmem.c:2683 ashmem_shrink_scan drivers/staging/android/ashmem.c:462 [inline] ashmem_shrink_scan+0x1c3/0x4c0 drivers/staging/android/ashmem.c:446 ashmem_ioctl+0x29b/0xdd0 drivers/staging/android/ashmem.c:804 vfs_ioctl fs/ioctl.c:43 [inline] file_ioctl fs/ioctl.c:493 [inline] do_vfs_ioctl+0xb87/0x11d0 fs/ioctl.c:677 SYSC_ioctl fs/ioctl.c:694 [inline] SyS_ioctl+0x8f/0xc0 fs/ioctl.c:685 do_syscall_64+0x1ad/0x5c0 arch/x86/entry/common.c:288 entry_SYSCALL_64_after_swapgs+0x5d/0xdb lock_acquire+0x133/0x3d0 kernel/locking/lockdep.c:3759 __mutex_lock_common kernel/locking/mutex.c:521 [inline] mutex_lock_nested+0xc7/0x920 kernel/locking/mutex.c:621 ashmem_mmap+0x53/0x470 drivers/staging/android/ashmem.c:378 mmap_region+0x7e7/0xfa0 mm/mmap.c:1726 do_mmap+0x539/0xbc0 mm/mmap.c:1505 do_mmap_pgoff include/linux/mm.h:2066 [inline] vm_mmap_pgoff+0x179/0x1c0 mm/util.c:329 SYSC_mmap_pgoff mm/mmap.c:1555 [inline] SyS_mmap_pgoff+0xfa/0x1b0 mm/mmap.c:1513 SYSC_mmap arch/x86/kernel/sys_x86_64.c:96 [inline] SyS_mmap+0x16/0x20 arch/x86/kernel/sys_x86_64.c:87 do_syscall_64+0x1ad/0x5c0 arch/x86/entry/common.c:288 entry_SYSCALL_64_after_swapgs+0x5d/0xdb check_prev_add kernel/locking/lockdep.c:1828 [inline] check_prevs_add kernel/locking/lockdep.c:1938 [inline] validate_chain kernel/locking/lockdep.c:2265 [inline] __lock_acquire+0x2d22/0x4390 kernel/locking/lockdep.c:3345 lock_acquire+0x133/0x3d0 kernel/locking/lockdep.c:3759 down_read+0x44/0xb0 kernel/locking/rwsem.c:22 __do_page_fault+0x7bd/0xa60 arch/x86/mm/fault.c:1337 do_page_fault+0x28/0x30 arch/x86/mm/fault.c:1464 page_fault+0x25/0x30 arch/x86/entry/entry_64.S:956 generic_perform_write+0x1b6/0x500 mm/filemap.c:2930 __generic_file_write_iter+0x340/0x530 mm/filemap.c:3065 generic_file_write_iter+0x38a/0x630 mm/filemap.c:3093 new_sync_write fs/read_write.c:498 [inline] __vfs_write+0x3c1/0x560 fs/read_write.c:511 vfs_write+0x185/0x520 fs/read_write.c:559 SYSC_write fs/read_write.c:607 [inline] SyS_write+0x121/0x270 fs/read_write.c:599 do_syscall_64+0x1ad/0x5c0 arch/x86/entry/common.c:288 entry_SYSCALL_64_after_swapgs+0x5d/0xdb other info that might help us debug this: Chain exists of: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&sb->s_type->i_mutex_key#10); lock(ashmem_mutex); lock(&sb->s_type->i_mutex_key#10); lock(&mm->mmap_sem); *** DEADLOCK *** 2 locks held by syz-executor.5/25788: #0: (sb_writers#6){.+.+.+}, at: [<000000009d7ed5ef>] file_start_write include/linux/fs.h:2645 [inline] #0: (sb_writers#6){.+.+.+}, at: [<000000009d7ed5ef>] vfs_write+0x3e9/0x520 fs/read_write.c:558 #1: (&sb->s_type->i_mutex_key#10){+.+.+.}, at: [<00000000664eaf70>] inode_lock include/linux/fs.h:771 [inline] #1: (&sb->s_type->i_mutex_key#10){+.+.+.}, at: [<00000000664eaf70>] generic_file_write_iter+0x9a/0x630 mm/filemap.c:3090 stack backtrace: CPU: 0 PID: 25788 Comm: syz-executor.5 Not tainted 4.9.203-syzkaller #0 ffff8801d85e75d8 ffffffff81b55f6b ffffffff83cae670 ffffffff83cb75e0 ffffffff83cf52c0 ffffffff8424ff40 ffff8801bd160000 ffff8801d85e7630 ffffffff81406eaa dffffc0000000000 ffffffff8407a2c0 ffff8801bd160900 Call Trace: [<00000000af18ab1f>] __dump_stack lib/dump_stack.c:15 [inline] [<00000000af18ab1f>] dump_stack+0xcb/0x130 lib/dump_stack.c:56 [<000000000062195a>] print_circular_bug.cold+0x2f6/0x454 kernel/locking/lockdep.c:1202 [<00000000c4c3932e>] check_prev_add kernel/locking/lockdep.c:1828 [inline] [<00000000c4c3932e>] check_prevs_add kernel/locking/lockdep.c:1938 [inline] [<00000000c4c3932e>] validate_chain kernel/locking/lockdep.c:2265 [inline] [<00000000c4c3932e>] __lock_acquire+0x2d22/0x4390 kernel/locking/lockdep.c:3345 [<00000000d86ea0c0>] lock_acquire+0x133/0x3d0 kernel/locking/lockdep.c:3759 [<000000003338faac>] down_read+0x44/0xb0 kernel/locking/rwsem.c:22 [<000000006652e125>] __do_page_fault+0x7bd/0xa60 arch/x86/mm/fault.c:1337 [<000000007c2a4ef7>] do_page_fault+0x28/0x30 arch/x86/mm/fault.c:1464 [<00000000cad41655>] page_fault+0x25/0x30 arch/x86/entry/entry_64.S:956 [<00000000f9a0d1d3>] generic_perform_write+0x1b6/0x500 mm/filemap.c:2930 [<00000000f4410dc2>] __generic_file_write_iter+0x340/0x530 mm/filemap.c:3065 [<000000005d93193d>] generic_file_write_iter+0x38a/0x630 mm/filemap.c:3093 [<00000000c3814b53>] new_sync_write fs/read_write.c:498 [inline] [<00000000c3814b53>] __vfs_write+0x3c1/0x560 fs/read_write.c:511 [<00000000220eeb8d>] vfs_write+0x185/0x520 fs/read_write.c:559 [<0000000042ffac6a>] SYSC_write fs/read_write.c:607 [inline] [<0000000042ffac6a>] SyS_write+0x121/0x270 fs/read_write.c:599 [<000000004f13bc74>] do_syscall_64+0x1ad/0x5c0 arch/x86/entry/common.c:288 [<000000005a91d53c>] entry_SYSCALL_64_after_swapgs+0x5d/0xdb audit: type=1400 audit(1574684397.548:2583): avc: denied { prog_load } for pid=25795 comm="syz-executor.5" 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(1574684397.548:2584): avc: denied { set_context_mgr } for pid=25798 comm="syz-executor.3" 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 audit: type=1400 audit(1574684397.578:2585): avc: denied { prog_load } for pid=25794 comm="syz-executor.0" 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(1574684397.808:2586): avc: denied { set_context_mgr } for pid=25831 comm="syz-executor.2" 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 audit: type=1400 audit(1574684397.858:2587): avc: denied { call } for pid=25831 comm="syz-executor.2" 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 audit: type=1400 audit(1574684397.868:2588): avc: denied { transfer } for pid=25831 comm="syz-executor.2" 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: 25831:25832 got transaction with invalid number of fds (7021822889313567588) binder: 25831:25832 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder: 25835:25836 got transaction with invalid number of fds (7021822889313567588) binder: 25835:25836 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 audit_printk_skb: 9 callbacks suppressed audit: type=1400 audit(1574684400.598:2593): avc: denied { prog_load } for pid=25844 comm="syz-executor.0" 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(1574684400.598:2592): avc: denied { prog_load } for pid=25842 comm="syz-executor.5" 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(1574684400.608:2594): avc: denied { set_context_mgr } for pid=25845 comm="syz-executor.3" 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 audit: type=1400 audit(1574684400.628:2595): avc: denied { set_context_mgr } for pid=25843 comm="syz-executor.2" 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 audit: type=1400 audit(1574684400.658:2596): avc: denied { call } for pid=25843 comm="syz-executor.2" 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 audit: type=1400 audit(1574684400.658:2597): avc: denied { transfer } for pid=25843 comm="syz-executor.2" 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: 25843:25852 got transaction with invalid number of fds (7021822889313567588) binder: 25843:25852 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 audit: type=1400 audit(1574684400.868:2598): avc: denied { set_context_mgr } for pid=25864 comm="syz-executor.2" 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 audit: type=1400 audit(1574684400.888:2599): avc: denied { set_context_mgr } for pid=25862 comm="syz-executor.3" 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 audit: type=1400 audit(1574684400.948:2600): avc: denied { call } for pid=25862 comm="syz-executor.3" 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 audit: type=1400 audit(1574684400.948:2601): avc: denied { transfer } for pid=25862 comm="syz-executor.3" 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: 25862:25868 got transaction with invalid number of fds (7021822889313567588) binder: 25862:25868 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder: 25874:25877 got transaction with invalid number of fds (7021822889313567588) binder: 25874:25877 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder: 25876:25878 got transaction with invalid number of fds (7021822889313567588) binder: 25876:25878 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder_alloc: 25872: binder_alloc_buf, no vma binder: 25872:25873 transaction failed 29189/-3, size 96-24 line 3284 binder: undelivered TRANSACTION_ERROR: 29189 binder: 25884:25886 got transaction with invalid number of fds (7021822889313567588) binder: 25888:25891 got transaction with invalid number of fds (7021822889313567588) binder: 25888:25891 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder: 25882:25885 got transaction with invalid number of fds (7021822889313567588) binder: 25882:25885 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201 binder: 25884:25886 transaction failed 29201/-22, size 96-24 line 3475 binder: 25901:25904 got transaction with invalid number of fds (7021822889313567588) binder: undelivered TRANSACTION_ERROR: 29201 binder: 25901:25904 transaction failed 29201/-22, size 96-24 line 3475 binder: undelivered TRANSACTION_ERROR: 29201