syzbot


BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range (2)

Status: closed as invalid on 2018/02/14 08:58
First crash: 2252d, last: 2252d
Similar bugs (6)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
android-44 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range 17 2197d 2235d 0/2 auto-closed as invalid on 2019/02/22 13:09
android-49 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range (6) 33 2200d 2244d 0/3 auto-closed as invalid on 2019/02/22 13:39
android-49 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range 3 2254d 2254d 0/3 closed as invalid on 2018/02/12 10:58
android-49 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range (5) 1 2245d 2245d 0/3 closed as invalid on 2018/02/20 14:58
android-49 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range (4) 1 2249d 2249d 0/3 closed as invalid on 2018/02/17 08:58
android-49 BUG: using __this_cpu_read() in preemptible code in __vmalloc_node_range (3) 1 2251d 2251d 0/3 closed as invalid on 2018/02/15 07:58

Sample crash report:
syz-executor7: vmalloc: allocation failure: 0 bytes, mode:0x24000c2(GFP_KERNEL|__GFP_HIGHMEM)
CPU: 1 PID: 5483 Comm: syz-executor7 Not tainted 4.9.81-g1a93831 #33
BUG: using __this_cpu_read() in preemptible [00000000] code: syz-executor1/5491
caller is __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 ffff8801bd52f8f0 ffffffff81d94e69 1ffff10037aa5f21 ffff8801b9a86000
 ffffffff83ab9320 0000000000000001 0000000000400000 ffff8801bd52fa00
 ffffffff81451df2 024000c2bd52f940 0000000041b58ab3 ffffffff8419579d
Call Trace:
 [<ffffffff81d94e69>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d94e69>] dump_stack+0xc1/0x128 lib/dump_stack.c:51
 [<ffffffff81451df2>] warn_alloc+0x212/0x240 mm/page_alloc.c:3056
 [<ffffffff814ffdc5>] __vmalloc_node_range+0x3f5/0x5f0 mm/vmalloc.c:1722
 [<ffffffff8150008b>] __vmalloc_node mm/vmalloc.c:1744 [inline]
 [<ffffffff8150008b>] __vmalloc_node_flags mm/vmalloc.c:1758 [inline]
 [<ffffffff8150008b>] vmalloc+0x5b/0x70 mm/vmalloc.c:1773
 [<ffffffff81bff820>] sel_write_load+0x130/0xfd0 security/selinux/selinuxfs.c:514
 [<ffffffff8156e633>] __vfs_write+0x103/0x680 fs/read_write.c:510
 [<ffffffff81570319>] vfs_write+0x189/0x530 fs/read_write.c:560
 [<ffffffff8157418f>] SYSC_pwrite64 fs/read_write.c:649 [inline]
 [<ffffffff8157418f>] SyS_pwrite64+0x13f/0x170 fs/read_write.c:636
 [<ffffffff81006505>] do_syscall_64+0x1a5/0x490 arch/x86/entry/common.c:282
 [<ffffffff838b3dbd>] entry_SYSCALL_64_after_swapgs+0x47/0xc5
CPU: 0 PID: 5491 Comm: syz-executor1 Not tainted 4.9.81-g1a93831 #33
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Mem-Info:
active_anon:56220 inactive_anon:45 isolated_anon:0
 active_file:3491 inactive_file:8270 isolated_file:0
 unevictable:0 dirty:6316 writeback:0 unstable:0
 slab_reclaimable:5472 slab_unreclaimable:59761
 mapped:24146 shmem:51 pagetables:720 bounce:0
 free:1472496 free_pcp:338 free_cma:0
Node 0 active_anon:224880kB inactive_anon:180kB active_file:13964kB inactive_file:33080kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:96584kB dirty:25264kB writeback:0kB shmem:204kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 71680kB writeback_tmp:0kB unstable:0kB pages_scanned:0 all_unreclaimable? no
DMA free:15908kB min:160kB low:200kB high:240kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
DMA32 free:2980076kB min:30592kB low:38240kB high:45888kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129292kB managed:2980720kB mlocked:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:644kB local_pcp:0kB free_cma:0kB
Normal free:2894000kB min:36824kB low:46028kB high:55232kB active_anon:224880kB inactive_anon:180kB active_file:13964kB inactive_file:33080kB unevictable:0kB writepending:25264kB present:4718592kB managed:3585212kB mlocked:0kB slab_reclaimable:21888kB slab_unreclaimable:239044kB kernel_stack:6176kB pagetables:2880kB bounce:0kB free_pcp:708kB local_pcp:508kB free_cma:0kB
DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15908kB
Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
11811 total pagecache pages
0 pages in swap cache
Swap cache stats: add 0, delete 0, find 0/0
Free swap  = 0kB
Total swap = 0kB
1965969 pages RAM
0 pages HighMem/MovableOnly
320509 pages reserved
audit: type=1400 audit(1518598048.611:30): avc:  denied  { write } for  pid=5476 comm="syz-executor7" name="net" dev="proc" ino=14633 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=dir permissive=1
audit: type=1400 audit(1518598048.611:31): avc:  denied  { add_name } for  pid=5476 comm="syz-executor7" name="pfkey" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=dir permissive=1
audit: type=1400 audit(1518598048.611:32): avc:  denied  { create } for  pid=5476 comm="syz-executor7" name="pfkey" scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:object_r:insmod_t:s0 tclass=file permissive=1
 ffff8801bdaef418 ffffffff81d94e69 0000000000000000 ffffffff83c18e00
 ffffffff83f45ae0 ffff8801bdae0000 0000000000000003 ffff8801bdaef458
 ffffffff81dfc464 ffff8801bdaef470 ffffffff83f45ae0 dffffc0000000000
Call Trace:
 [<ffffffff81d94e69>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d94e69>] dump_stack+0xc1/0x128 lib/dump_stack.c:51
 [<ffffffff81dfc464>] check_preemption_disabled+0x1d4/0x200 lib/smp_processor_id.c:46
 [<ffffffff81dfc4cc>] __this_cpu_preempt_check+0x1c/0x20 lib/smp_processor_id.c:62
 [<ffffffff833fd268>] ipcomp_alloc_tfms net/xfrm/xfrm_ipcomp.c:286 [inline]
 [<ffffffff833fd268>] ipcomp_init_state+0x188/0x930 net/xfrm/xfrm_ipcomp.c:363
 [<ffffffff83513875>] ipcomp6_init_state+0xb5/0x820 net/ipv6/ipcomp6.c:165
 [<ffffffff833db957>] __xfrm_init_state+0x3e7/0xb30 net/xfrm/xfrm_state.c:2096
 [<ffffffff833faab6>] xfrm_state_construct net/xfrm/xfrm_user.c:590 [inline]
 [<ffffffff833faab6>] xfrm_add_sa+0x1916/0x2e40 net/xfrm/xfrm_user.c:639
 [<ffffffff833eb0fd>] xfrm_user_rcv_msg+0x40d/0x6a0 net/xfrm/xfrm_user.c:2525
 [<ffffffff8309552e>] netlink_rcv_skb+0x13e/0x370 net/netlink/af_netlink.c:2351
 [<ffffffff833e75ff>] xfrm_netlink_rcv+0x6f/0x90 net/xfrm/xfrm_user.c:2533
 [<ffffffff830940b1>] netlink_unicast_kernel net/netlink/af_netlink.c:1275 [inline]
 [<ffffffff830940b1>] netlink_unicast+0x511/0x750 net/netlink/af_netlink.c:1301
 [<ffffffff83094bd8>] netlink_sendmsg+0x8e8/0xc50 net/netlink/af_netlink.c:1847
 [<ffffffff82ed7baa>] sock_sendmsg_nosec net/socket.c:635 [inline]
 [<ffffffff82ed7baa>] sock_sendmsg+0xca/0x110 net/socket.c:645
 [<ffffffff82ed97c1>] ___sys_sendmsg+0x6d1/0x7e0 net/socket.c:1969
 [<ffffffff82edb7f6>] __sys_sendmsg+0xd6/0x190 net/socket.c:2003
 [<ffffffff82edb8dd>] SYSC_sendmsg net/socket.c:2014 [inline]
 [<ffffffff82edb8dd>] SyS_sendmsg+0x2d/0x50 net/socket.c:2010
 [<ffffffff81006505>] do_syscall_64+0x1a5/0x490 arch/x86/entry/common.c:282
 [<ffffffff838b3dbd>] entry_SYSCALL_64_after_swapgs+0x47/0xc5
audit: type=1400 audit(1518598049.311:33): avc:  denied  { create } for  pid=5515 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
IPv4: Oversized IP packet from 127.0.0.1
binder: BINDER_SET_CONTEXT_MGR already set
binder: 5634:5636 ioctl 40046207 0 returned -16
netlink: 4 bytes leftover after parsing attributes in process `syz-executor4'.
binder: release 5804:5812 transaction 5 in, still active
binder: send failed reply for transaction 5 to 5804:5825
binder: undelivered TRANSACTION_COMPLETE
binder: undelivered TRANSACTION_ERROR: 29189
binder: release 5804:5825 transaction 7 out, still active
binder: undelivered TRANSACTION_COMPLETE
binder: send failed reply for transaction 7, target dead
syz-executor1 uses obsolete (PF_INET,SOCK_PACKET)
binder: 5851:5867 transaction failed 29189/-22, size 0-0 line 3004
binder: 5851:5872 transaction failed 29189/-22, size 0-0 line 3004
binder: undelivered TRANSACTION_ERROR: 29189
binder: undelivered TRANSACTION_ERROR: 29189
device lo entered promiscuous mode
device lo left promiscuous mode
binder_alloc: 5997: binder_alloc_buf, no vma
binder: 5997:6013 transaction failed 29189/-3, size 0-0 line 3127
binder: send failed reply for transaction 11 to 5997:5999
binder: BINDER_SET_CONTEXT_MGR already set
binder: 5997:6027 ioctl 40046207 0 returned -16
binder_alloc: 5997: binder_alloc_buf, no vma
binder: 5997:6013 transaction failed 29189/-3, size 0-0 line 3127
binder: 5997:6046 got reply transaction with no transaction stack
binder: 5997:6046 transaction failed 29201/-71, size 0-0 line 2920
binder: undelivered TRANSACTION_ERROR: 29201
binder: undelivered TRANSACTION_COMPLETE
binder: undelivered TRANSACTION_ERROR: 29189
binder: undelivered TRANSACTION_ERROR: 29190
binder: undelivered TRANSACTION_ERROR: 29189
TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies.  Check SNMP counters.
binder: 6119:6125 transaction failed 29189/-22, size 0-0 line 3004
binder: 6119:6125 ioctl c0306201 20005fd0 returned -14
qtaguid: iface_stat: iface_check_stats_reset_and_adjust(lo): iface reset its stats unexpectedly
binder: 6119:6140 ioctl c0306201 20005fd0 returned -14
binder: 6119:6125 transaction failed 29189/-22, size 0-0 line 3004
binder: undelivered TRANSACTION_ERROR: 29189
binder: 6181:6182 ERROR: BC_REGISTER_LOOPER called without request
binder: 6181:6182 ERROR: BC_ENTER_LOOPER called after BC_REGISTER_LOOPER
binder: 6181:6182 ERROR: BC_REGISTER_LOOPER called without request
SELinux: ebitmap: truncated map
binder: 6406:6417 ioctl c058534f 20432000 returned -22
binder: 6406:6417 unknown command 0
binder: 6406:6417 ioctl c0306201 20007000 returned -22
binder: 6406:6417 ioctl c058534f 20432000 returned -22
binder: 6406:6426 Acquire 1 refcount change on invalid ref 0 ret -22
binder: 6406:6426 unknown command 0
binder: 6406:6426 ioctl c0306201 20007000 returned -22
binder: 6406:6426 BC_REQUEST_DEATH_NOTIFICATION invalid ref 0
binder: 6406:6447 BC_CLEAR_DEATH_NOTIFICATION invalid ref 0
binder: 6406:6447 BC_DEAD_BINDER_DONE 0000000000000000 not found
binder: undelivered death notification, 0000000000000000
IPv4: Oversized IP packet from 127.0.0.1
IPv4: Oversized IP packet from 127.0.0.1
binder: 6541:6542 ioctl c0306201 204f6fd0 returned -14
binder: 6541:6546 ioctl c0306201 204f6fd0 returned -14
audit_printk_skb: 51 callbacks suppressed
audit: type=1400 audit(1518598052.951:51): avc:  denied  { setopt } for  pid=6559 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_generic_socket permissive=1
netlink: 12 bytes leftover after parsing attributes in process `syz-executor7'.
PF_BRIDGE: RTM_NEWNEIGH with invalid address
FAULT_FLAG_ALLOW_RETRY missing 30
CPU: 0 PID: 6561 Comm: syz-executor5 Not tainted 4.9.81-g1a93831 #33
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 ffff8801d6557580 ffffffff81d94e69 ffff8801d6557860 0000000000000000
 ffff8801b9848d10 ffff8801d6557750 ffff8801b9848c00 ffff8801d6557778
 ffffffff8166268a 0000000000002a2e ffff8801b1f350f0 ffff8801b1f350a0
Call Trace:
 [<ffffffff81d94e69>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d94e69>] dump_stack+0xc1/0x128 lib/dump_stack.c:51
 [<ffffffff8166268a>] handle_userfault+0xa3a/0x1310 fs/userfaultfd.c:323
 [<ffffffff814d0ef1>] do_anonymous_page mm/memory.c:2747 [inline]
 [<ffffffff814d0ef1>] handle_pte_fault mm/memory.c:3488 [inline]
 [<ffffffff814d0ef1>] __handle_mm_fault mm/memory.c:3577 [inline]
 [<ffffffff814d0ef1>] handle_mm_fault+0x1fd1/0x2530 mm/memory.c:3614
 [<ffffffff810de642>] __do_page_fault+0x5c2/0xd40 arch/x86/mm/fault.c:1407
 [<ffffffff810dede7>] do_page_fault+0x27/0x30 arch/x86/mm/fault.c:1470
 [<ffffffff838b4f48>] page_fault+0x28/0x30 arch/x86/entry/entry_64.S:939
 [<ffffffff815ae86a>] vfs_ioctl fs/ioctl.c:43 [inline]
 [<ffffffff815ae86a>] do_vfs_ioctl+0x1aa/0x1140 fs/ioctl.c:679
 [<ffffffff815af88f>] SYSC_ioctl fs/ioctl.c:694 [inline]
 [<ffffffff815af88f>] SyS_ioctl+0x8f/0xc0 fs/ioctl.c:685
 [<ffffffff81006505>] do_syscall_64+0x1a5/0x490 arch/x86/entry/common.c:282
 [<ffffffff838b3dbd>] entry_SYSCALL_64_after_swapgs+0x47/0xc5
audit: type=1400 audit(1518598053.031:52): avc:  denied  { ioctl } for  pid=6559 comm="syz-executor1" path="socket:[15729]" dev="sockfs" ino=15729 ioctlcmd=0x5411 scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=netlink_generic_socket permissive=1
audit: type=1400 audit(1518598053.041:53): avc:  denied  { net_broadcast } for  pid=6586 comm="syz-executor7" capability=11  scontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tcontext=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 tclass=cap_userns permissive=1
netlink: 17 bytes leftover after parsing attributes in process `syz-executor3'.
netlink: 17 bytes leftover after parsing attributes in process `syz-executor3'.
binder: binder_mmap: 6669 20000000-20001000 bad vm_flags failed -1
binder_alloc: 6669: binder_alloc_buf, no vma
binder: 6669:6677 transaction failed 29189/-3, size 0-0 line 3127
binder: 6669:6686 got reply transaction with no transaction stack
binder: 6669:6686 transaction failed 29201/-71, size 112-8 line 2920
binder: BINDER_SET_CONTEXT_MGR already set
binder: 6669:6692 ioctl 40046207 0 returned -16
binder: binder_mmap: 6669 20000000-20001000 bad vm_flags failed -1
binder_alloc: 6669: binder_alloc_buf, no vma
binder: 6669:6686 got reply transaction with no transaction stack
binder: 6669:6686 transaction failed 29201/-71, size 112-8 line 2920
binder: 6669:6677 transaction failed 29189/-3, size 0-0 line 3127
binder: undelivered TRANSACTION_ERROR: 29189
binder: undelivered TRANSACTION_ERROR: 29201
binder: undelivered TRANSACTION_ERROR: 29189
binder: undelivered TRANSACTION_ERROR: 29201
netlink: 8 bytes leftover after parsing attributes in process `syz-executor1'.
IPVS: Creating netns size=2536 id=10
random: crng init done
netlink: 17 bytes leftover after parsing attributes in process `syz-executor3'.
netlink: 17 bytes leftover after parsing attributes in process `syz-executor3'.
netlink: 28 bytes leftover after parsing attributes in process `syz-executor5'.
audit: type=1401 audit(1518598058.021:54): op=setxattr invalid_context="&%em1wlan0"
netlink: 28 bytes leftover after parsing attributes in process `syz-executor5'.
audit: type=1401 audit(1518598058.071:55): op=setxattr invalid_context="&%em1wlan0"

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2018/02/14 08:47 https://android.googlesource.com/kernel/common android-4.9 1a938310b8af 88bc17df .config console log report ci-android-49-kasan-gce
* Struck through repros no longer work on HEAD.