======================================================
[ INFO: possible circular locking dependency detected ]
4.4.120-gd63fdf6 #29 Not tainted
-------------------------------------------------------
syz-executor7/10284 is trying to acquire lock:
 (&sb->s_type->i_mutex_key#10){+.+.+.}, at: [<ffffffff81463361>] shmem_file_llseek+0xf1/0x240 mm/shmem.c:1816

but task is already holding lock:
 (ashmem_mutex){+.+.+.}, at: [<ffffffff82c62016>] ashmem_llseek+0x56/0x1f0 drivers/staging/android/ashmem.c:330

which lock already depends on the new lock.


the existing dependency chain (in reverse order) is:

       [<ffffffff8123d7ce>] lock_acquire+0x15e/0x460 kernel/locking/lockdep.c:3592
       [<ffffffff8376a39b>] __mutex_lock_common kernel/locking/mutex.c:521 [inline]
       [<ffffffff8376a39b>] mutex_lock_nested+0xbb/0x850 kernel/locking/mutex.c:621
       [<ffffffff82c61463>] ashmem_mmap+0x53/0x400 drivers/staging/android/ashmem.c:366
       [<ffffffff814b0e4f>] mmap_region+0x94f/0x1250 mm/mmap.c:1664
       [<ffffffff814b1c4d>] do_mmap+0x4fd/0x9d0 mm/mmap.c:1441
       [<ffffffff814700ce>] do_mmap_pgoff include/linux/mm.h:1915 [inline]
       [<ffffffff814700ce>] vm_mmap_pgoff+0x16e/0x1c0 mm/util.c:296
       [<ffffffff814afe1f>] SYSC_mmap_pgoff mm/mmap.c:1491 [inline]
       [<ffffffff814afe1f>] SyS_mmap_pgoff+0x33f/0x560 mm/mmap.c:1449
       [<ffffffff81006d91>] do_syscall_32_irqs_on arch/x86/entry/common.c:392 [inline]
       [<ffffffff81006d91>] do_fast_syscall_32+0x321/0x8a0 arch/x86/entry/common.c:459
       [<ffffffff837752ea>] sysenter_flags_fixed+0xd/0x17

       [<ffffffff8123d7ce>] lock_acquire+0x15e/0x460 kernel/locking/lockdep.c:3592
       [<ffffffff814956ea>] __might_fault+0x14a/0x1d0 mm/memory.c:3810
       [<ffffffff8155ab22>] copy_to_user arch/x86/include/asm/uaccess.h:760 [inline]
       [<ffffffff8155ab22>] filldir+0x162/0x2d0 fs/readdir.c:180
       [<ffffffff8159820e>] dir_emit_dot include/linux/fs.h:3070 [inline]
       [<ffffffff8159820e>] dir_emit_dots include/linux/fs.h:3081 [inline]
       [<ffffffff8159820e>] dcache_readdir+0x11e/0x7b0 fs/libfs.c:150
       [<ffffffff8155a768>] iterate_dir+0x1c8/0x420 fs/readdir.c:42
       [<ffffffff8155b45a>] SYSC_getdents fs/readdir.c:215 [inline]
       [<ffffffff8155b45a>] SyS_getdents+0x14a/0x270 fs/readdir.c:196
       [<ffffffff8377395f>] entry_SYSCALL_64_fastpath+0x1c/0x98

       [<ffffffff8123ab2f>] check_prev_add kernel/locking/lockdep.c:1853 [inline]
       [<ffffffff8123ab2f>] check_prevs_add kernel/locking/lockdep.c:1958 [inline]
       [<ffffffff8123ab2f>] validate_chain kernel/locking/lockdep.c:2144 [inline]
       [<ffffffff8123ab2f>] __lock_acquire+0x371f/0x4b50 kernel/locking/lockdep.c:3213
       [<ffffffff8123d7ce>] lock_acquire+0x15e/0x460 kernel/locking/lockdep.c:3592
       [<ffffffff8376a39b>] __mutex_lock_common kernel/locking/mutex.c:521 [inline]
       [<ffffffff8376a39b>] mutex_lock_nested+0xbb/0x850 kernel/locking/mutex.c:621
       [<ffffffff81463361>] shmem_file_llseek+0xf1/0x240 mm/shmem.c:1816
       [<ffffffff8151c762>] vfs_llseek+0xa2/0xd0 fs/read_write.c:260
       [<ffffffff82c620a7>] ashmem_llseek+0xe7/0x1f0 drivers/staging/android/ashmem.c:342
       [<ffffffff8151e6db>] vfs_llseek fs/read_write.c:260 [inline]
       [<ffffffff8151e6db>] SYSC_lseek fs/read_write.c:285 [inline]
       [<ffffffff8151e6db>] SyS_lseek fs/read_write.c:276 [inline]
       [<ffffffff8151e6db>] C_SYSC_lseek fs/read_write.c:297 [inline]
       [<ffffffff8151e6db>] compat_SyS_lseek+0xeb/0x170 fs/read_write.c:295
       [<ffffffff81006d91>] do_syscall_32_irqs_on arch/x86/entry/common.c:392 [inline]
       [<ffffffff81006d91>] do_fast_syscall_32+0x321/0x8a0 arch/x86/entry/common.c:459
       [<ffffffff837752ea>] sysenter_flags_fixed+0xd/0x17

other info that might help us debug this:

Chain exists of:
 Possible unsafe locking scenario:

       CPU0                    CPU1
       ----                    ----
  lock(ashmem_mutex);
                               lock(&mm->mmap_sem);
                               lock(ashmem_mutex);
  lock(&sb->s_type->i_mutex_key#10);

 *** DEADLOCK ***

1 lock held by syz-executor7/10284:
 #0:  (ashmem_mutex){+.+.+.}, at: [<ffffffff82c62016>] ashmem_llseek+0x56/0x1f0 drivers/staging/android/ashmem.c:330

stack backtrace:
CPU: 0 PID: 10284 Comm: syz-executor7 Not tainted 4.4.120-gd63fdf6 #29
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 0000000000000000 5bef5ec2b4b9f3c8 ffff8800b5737a58 ffffffff81d0408d
 ffffffff8519fe60 ffffffff851a9d00 ffffffff851be610 ffff8801c1f6e8f8
 ffff8801c1f6e000 ffff8800b5737aa0 ffffffff81233ba1 ffff8801c1f6e8f8
Call Trace:
 [<ffffffff81d0408d>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d0408d>] dump_stack+0xc1/0x124 lib/dump_stack.c:51
 [<ffffffff81233ba1>] print_circular_bug+0x271/0x310 kernel/locking/lockdep.c:1226
 [<ffffffff8123ab2f>] check_prev_add kernel/locking/lockdep.c:1853 [inline]
 [<ffffffff8123ab2f>] check_prevs_add kernel/locking/lockdep.c:1958 [inline]
 [<ffffffff8123ab2f>] validate_chain kernel/locking/lockdep.c:2144 [inline]
 [<ffffffff8123ab2f>] __lock_acquire+0x371f/0x4b50 kernel/locking/lockdep.c:3213
 [<ffffffff8123d7ce>] lock_acquire+0x15e/0x460 kernel/locking/lockdep.c:3592
 [<ffffffff8376a39b>] __mutex_lock_common kernel/locking/mutex.c:521 [inline]
 [<ffffffff8376a39b>] mutex_lock_nested+0xbb/0x850 kernel/locking/mutex.c:621
 [<ffffffff81463361>] shmem_file_llseek+0xf1/0x240 mm/shmem.c:1816
 [<ffffffff8151c762>] vfs_llseek+0xa2/0xd0 fs/read_write.c:260
 [<ffffffff82c620a7>] ashmem_llseek+0xe7/0x1f0 drivers/staging/android/ashmem.c:342
 [<ffffffff8151e6db>] vfs_llseek fs/read_write.c:260 [inline]
 [<ffffffff8151e6db>] SYSC_lseek fs/read_write.c:285 [inline]
 [<ffffffff8151e6db>] SyS_lseek fs/read_write.c:276 [inline]
 [<ffffffff8151e6db>] C_SYSC_lseek fs/read_write.c:297 [inline]
 [<ffffffff8151e6db>] compat_SyS_lseek+0xeb/0x170 fs/read_write.c:295
 [<ffffffff81006d91>] do_syscall_32_irqs_on arch/x86/entry/common.c:392 [inline]
 [<ffffffff81006d91>] do_fast_syscall_32+0x321/0x8a0 arch/x86/entry/common.c:459
 [<ffffffff837752ea>] sysenter_flags_fixed+0xd/0x17
netlink: 2 bytes leftover after parsing attributes in process `syz-executor6'.
binder: 10555:10559 got transaction to invalid handle
binder: 10555:10559 transaction failed 29201/-22, size 0-0 line 3005
binder: 10555:10559 got transaction to invalid handle
binder: 10555:10559 transaction failed 29201/-22, size 0-0 line 3005
binder: undelivered TRANSACTION_ERROR: 29201
binder: undelivered TRANSACTION_ERROR: 29201
audit_printk_skb: 9 callbacks suppressed
audit: type=1400 audit(1521915927.371:50): avc:  denied  { create } for  pid=10607 comm="syz-executor7" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_rdma_socket permissive=1
binder: 10664:10666 BC_INCREFS_DONE u0000000000000000 no match
binder: 10664:10666 ERROR: BC_REGISTER_LOOPER called after BC_ENTER_LOOPER
audit: type=1326 audit(1521915928.421:51): auid=4294967295 uid=0 gid=0 ses=4294967295 subj=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 pid=10741 comm="syz-executor0" exe="/root/syz-executor0" sig=31 arch=40000003 syscall=240 compat=1 ip=0xf77c7ba9 code=0x0
BUG: using __this_cpu_read() in preemptible [00000000] code: syz-executor5/10806
caller is __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
CPU: 0 PID: 10806 Comm: syz-executor5 Not tainted 4.4.120-gd63fdf6 #29
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 0000000000000000 1e16e85889df64f3 ffff8801d338f648 ffffffff81d0408d
 0000000000000000 ffffffff839fe5a0 ffffffff83d0be20 ffff8801d496c800
 0000000000000003 ffff8801d338f688 ffffffff81d63fe4 ffff8801d338f6a0
Call Trace:
 [<ffffffff81d0408d>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d0408d>] dump_stack+0xc1/0x124 lib/dump_stack.c:51
 [<ffffffff81d63fe4>] check_preemption_disabled+0x1d4/0x200 lib/smp_processor_id.c:46
 [<ffffffff81d6404c>] __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
 [<ffffffff832e2f08>] ipcomp_alloc_tfms net/xfrm/xfrm_ipcomp.c:286 [inline]
 [<ffffffff832e2f08>] ipcomp_init_state+0x188/0x980 net/xfrm/xfrm_ipcomp.c:363
 [<ffffffff8324ac70>] ipcomp4_init_state+0xb0/0x7d0 net/ipv4/ipcomp.c:137
 [<ffffffff832c1817>] __xfrm_init_state+0x3e7/0xb30 net/xfrm/xfrm_state.c:2058
 [<ffffffff832c1f7a>] xfrm_init_state+0x1a/0x20 net/xfrm/xfrm_state.c:2084
 [<ffffffff8344681b>] pfkey_msg2xfrm_state net/key/af_key.c:1289 [inline]
 [<ffffffff8344681b>] pfkey_add+0x1fbb/0x3490 net/key/af_key.c:1506
 [<ffffffff8344a45b>] pfkey_process+0x68b/0x750 net/key/af_key.c:2834
 [<ffffffff8344bcb9>] pfkey_sendmsg+0x3a9/0x760 net/key/af_key.c:3678
 [<ffffffff82deba6a>] sock_sendmsg_nosec net/socket.c:625 [inline]
 [<ffffffff82deba6a>] sock_sendmsg+0xca/0x110 net/socket.c:635
 [<ffffffff82ded641>] ___sys_sendmsg+0x6c1/0x7c0 net/socket.c:1962
 [<ffffffff82def693>] __sys_sendmsg+0xd3/0x190 net/socket.c:1996
 [<ffffffff82eda56a>] C_SYSC_sendmsg net/compat.c:720 [inline]
 [<ffffffff82eda56a>] compat_SyS_sendmsg+0x2a/0x40 net/compat.c:718
 [<ffffffff81006d91>] do_syscall_32_irqs_on arch/x86/entry/common.c:392 [inline]
 [<ffffffff81006d91>] do_fast_syscall_32+0x321/0x8a0 arch/x86/entry/common.c:459
 [<ffffffff837752ea>] sysenter_flags_fixed+0xd/0x17
BUG: using __this_cpu_read() in preemptible [00000000] code: syz-executor5/10806
caller is __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
CPU: 0 PID: 10806 Comm: syz-executor5 Not tainted 4.4.120-gd63fdf6 #29
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 0000000000000000 1e16e85889df64f3 ffff8801d338f648 ffffffff81d0408d
 0000000000000000 ffffffff839fe5a0 ffffffff83d0be20 ffff8801d496c800
 0000000000000003 ffff8801d338f688 ffffffff81d63fe4 ffff8801d338f6a0
Call Trace:
 [<ffffffff81d0408d>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d0408d>] dump_stack+0xc1/0x124 lib/dump_stack.c:51
 [<ffffffff81d63fe4>] check_preemption_disabled+0x1d4/0x200 lib/smp_processor_id.c:46
 [<ffffffff81d6404c>] __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
 [<ffffffff832e2f08>] ipcomp_alloc_tfms net/xfrm/xfrm_ipcomp.c:286 [inline]
 [<ffffffff832e2f08>] ipcomp_init_state+0x188/0x980 net/xfrm/xfrm_ipcomp.c:363
 [<ffffffff8324ac70>] ipcomp4_init_state+0xb0/0x7d0 net/ipv4/ipcomp.c:137
 [<ffffffff832c1817>] __xfrm_init_state+0x3e7/0xb30 net/xfrm/xfrm_state.c:2058
 [<ffffffff832c1f7a>] xfrm_init_state+0x1a/0x20 net/xfrm/xfrm_state.c:2084
 [<ffffffff8344681b>] pfkey_msg2xfrm_state net/key/af_key.c:1289 [inline]
 [<ffffffff8344681b>] pfkey_add+0x1fbb/0x3490 net/key/af_key.c:1506
 [<ffffffff8344a45b>] pfkey_process+0x68b/0x750 net/key/af_key.c:2834
 [<ffffffff8344bcb9>] pfkey_sendmsg+0x3a9/0x760 net/key/af_key.c:3678
 [<ffffffff82deba6a>] sock_sendmsg_nosec net/socket.c:625 [inline]
 [<ffffffff82deba6a>] sock_sendmsg+0xca/0x110 net/socket.c:635
 [<ffffffff82ded641>] ___sys_sendmsg+0x6c1/0x7c0 net/socket.c:1962
 [<ffffffff82def693>] __sys_sendmsg+0xd3/0x190 net/socket.c:1996
 [<ffffffff82eda56a>] C_SYSC_sendmsg net/compat.c:720 [inline]
 [<ffffffff82eda56a>] compat_SyS_sendmsg+0x2a/0x40 net/compat.c:718
 [<ffffffff81006d91>] do_syscall_32_irqs_on arch/x86/entry/common.c:392 [inline]
 [<ffffffff81006d91>] do_fast_syscall_32+0x321/0x8a0 arch/x86/entry/common.c:459
 [<ffffffff837752ea>] sysenter_flags_fixed+0xd/0x17
TCP: request_sock_TCP: Possible SYN flooding on port 20000. Sending cookies.  Check SNMP counters.
TCP: request_sock_TCP: Possible SYN flooding on port 20000. Sending cookies.  Check SNMP counters.
binder: BINDER_SET_CONTEXT_MGR already set
binder: 11274:11276 ioctl 40046207 0 returned -16
sd 0:0:1:0: [sg0] tag#138 FAILED Result: hostbyte=DID_ABORT driverbyte=DRIVER_OK
sd 0:0:1:0: [sg0] tag#138 CDB: opcode=0x6
sd 0:0:1:0: [sg0] tag#138 CDB[00]: 06 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
sd 0:0:1:0: [sg0] tag#138 CDB[10]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
sd 0:0:1:0: [sg0] tag#138 CDB[20]: 00 00 00
sd 0:0:1:0: [sg0] tag#139 FAILED Result: hostbyte=DID_ABORT driverbyte=DRIVER_OK
sd 0:0:1:0: [sg0] tag#139 CDB: opcode=0x6
sd 0:0:1:0: [sg0] tag#139 CDB[00]: 06 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
sd 0:0:1:0: [sg0] tag#139 CDB[10]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
sd 0:0:1:0: [sg0] tag#139 CDB[20]: 00 00 00
audit: type=1400 audit(1521915931.711:52): avc:  denied  { create } for  pid=11457 comm="syz-executor5" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_crypto_socket permissive=1
audit: type=1400 audit(1521915931.901:53): avc:  denied  { create } for  pid=11527 comm="syz-executor5" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_connector_socket permissive=1
audit: type=1400 audit(1521915931.951:54): avc:  denied  { setopt } for  pid=11527 comm="syz-executor5" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_connector_socket permissive=1
audit: type=1400 audit(1521915932.971:55): avc:  denied  { create } for  pid=11755 comm="syz-executor0" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:systemd_systemctl_exec_t:s0 tclass=tcp_socket permissive=1
device lo entered promiscuous mode
device lo left promiscuous mode
audit: type=1400 audit(1521915933.281:56): avc:  denied  { getopt } for  pid=11856 comm="syz-executor1" 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
TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies.  Check SNMP counters.
TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies.  Check SNMP counters.
Option '                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                     Option '                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                     [   79.609540] audit: type=1400 audit(1521915933.821:57): avc:  denied  { ioctl } for  pid=11973 comm="syz-executor1" path="socket:[27011]" dev="sockfs" ino=27011 ioctlcmd=89b1 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
binder: 12168:12174 Acquire 1 refcount change on invalid ref 0 ret -22
binder: 12168:12174 BC_REQUEST_DEATH_NOTIFICATION invalid ref 0
binder: 12168:12174 BC_CLEAR_DEATH_NOTIFICATION invalid ref 0
binder: 12168:12174 unknown command 0
binder: 12168:12174 ioctl c0306201 20000040 returned -22
binder: 12168:12181 Acquire 1 refcount change on invalid ref 0 ret -22
binder: 12168:12181 BC_CLEAR_DEATH_NOTIFICATION invalid ref 0
binder: 12168:12174 BC_REQUEST_DEATH_NOTIFICATION invalid ref 0
binder: 12168:12181 unknown command 0
binder: 12168:12181 ioctl c0306201 20000040 returned -22
audit: type=1400 audit(1521915935.041:58): avc:  denied  { setattr } for  pid=12324 comm="syz-executor0" name="cmdline" dev="proc" ino=26352 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=file permissive=1
audit: type=1400 audit(1521915935.971:59): avc:  denied  { bind } for  pid=12503 comm="syz-executor3" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=system_u:object_r:systemd_systemctl_exec_t:s0 tclass=tcp_socket permissive=1
audit: type=1400 audit(1521915935.991:60): avc:  denied  { name_bind } for  pid=12503 comm="syz-executor3" src=20004 scontext=system_u:object_r:systemd_systemctl_exec_t:s0 tcontext=system_u:object_r:port_t:s0 tclass=tcp_socket permissive=1
audit: type=1400 audit(1521915936.021:61): avc:  denied  { node_bind } for  pid=12503 comm="syz-executor3" saddr=172.20.20.187 src=20004 scontext=system_u:object_r:systemd_systemctl_exec_t:s0 tcontext=system_u:object_r:node_t:s0 tclass=tcp_socket permissive=1