kernel BUG at kernel/time/timer.c:LINE!

49 views
Skip to first unread message

syzbot

unread,
Dec 8, 2019, 1:43:10 PM12/8/19
to syzkaller...@googlegroups.com
Hello,

syzbot found the following crash on:

HEAD commit: a844dc4c Linux 4.14.158
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=167c0aeae00000
kernel config: https://syzkaller.appspot.com/x/.config?x=c02bef505ffc02ff
dashboard link: https://syzkaller.appspot.com/bug?extid=bda828feeef0b6e68e3c
compiler: gcc (GCC) 9.0.0 20181231 (experimental)

Unfortunately, I don't have any reproducer for this crash yet.

IMPORTANT: if you fix the bug, please add the following tag to the commit:
Reported-by: syzbot+bda828...@syzkaller.appspotmail.com

binder: 13053:13058 ioctl 40046207 0 returned -16
sp0: Synchronizing with TNC
sp0: Found TNC
------------[ cut here ]------------
kernel BUG at kernel/time/timer.c:1089!
binder: BINDER_SET_CONTEXT_MGR already set
binder: 13053:13058 ioctl 40046207 0 returned -16
invalid opcode: 0000 [#1] PREEMPT SMP KASAN
Modules linked in:
CPU: 0 PID: 13056 Comm: syz-executor.1 Not tainted 4.14.158-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS
Google 01/01/2011
task: ffff888050258600 task.stack: ffff888059c78000
RIP: 0010:add_timer kernel/time/timer.c:1089 [inline]
RIP: 0010:add_timer+0x689/0xae0 kernel/time/timer.c:1087
RSP: 0018:ffff888059c7fb20 EFLAGS: 00010216
RAX: 0000000000040000 RBX: ffff888059c7fb90 RCX: ffffc90008035000
RDX: 00000000000073bc RSI: ffffffff81503e89 RDI: ffff8880730b3648
RBP: ffff888059c7fbb8 R08: ffff888050258600 R09: ffff888050258ea0
R10: 0000000000000000 R11: 0000000000000000 R12: ffff8880730b3640
R13: dffffc0000000000 R14: ffff888059c7fc88 R15: ffff8880730b3640
FS: 00007fef90426700(0000) GS:ffff8880aec00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007ffc07b15ee8 CR3: 000000004e611000 CR4: 00000000001426f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
decode_prio_command drivers/net/hamradio/6pack.c:934 [inline]
sixpack_decode drivers/net/hamradio/6pack.c:1003 [inline]
sixpack_receive_buf drivers/net/hamradio/6pack.c:458 [inline]
sixpack_receive_buf+0xc9a/0x1170 drivers/net/hamradio/6pack.c:435
tiocsti drivers/tty/tty_io.c:2186 [inline]
tty_ioctl+0xded/0x1320 drivers/tty/tty_io.c:2572
vfs_ioctl fs/ioctl.c:46 [inline]
file_ioctl fs/ioctl.c:500 [inline]
do_vfs_ioctl+0x7ae/0x1060 fs/ioctl.c:684
SYSC_ioctl fs/ioctl.c:701 [inline]
SyS_ioctl+0x8f/0xc0 fs/ioctl.c:692
do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a6f9
RSP: 002b:00007fef90425c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 000000000045a6f9
RDX: 0000000020000000 RSI: 0000000000005412 RDI: 0000000000000004
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fef904266d4
R13: 00000000004c585b R14: 00000000004dba30 R15: 00000000ffffffff
Code: 84 8a 00 00 00 e8 c8 10 0d 00 65 ff 0d 61 af b1 7e 0f 85 3c fd ff ff
e8 b6 10 0d 00 e8 05 04 b0 ff e9 2d fd ff ff e8 a7 10 0d 00 <0f> 0b e8 a0
10 0d 00 49 c7 c5 80 4a 02 00 e8 14 b3 ba 01 48 ba
RIP: add_timer kernel/time/timer.c:1089 [inline] RSP: ffff888059c7fb20
RIP: add_timer+0x689/0xae0 kernel/time/timer.c:1087 RSP: ffff888059c7fb20
6pack: protocol violation
kobject: 'loop2' (ffff8880a40624e0): kobject_uevent_env
IPVS: ftp: loaded support on port[0] = 21
kobject: 'loop2' (ffff8880a40624e0): fill_kobj_path: path
= '/devices/virtual/block/loop2'
kobject: 'lo' (ffff888059a6c7b0): kobject_add_internal: parent: 'net',
set: 'devices'
6pack: bad checksum 6d
6pack: protocol violation
kobject: 'lo' (ffff888059a6c7b0): kobject_uevent_env
6pack: protocol violation
6pack: protocol violation
kobject: 'kvm' (ffff8882194e6110): kobject_uevent_env
kobject: 'lo' (ffff888059a6c7b0): fill_kobj_path: path
= '/devices/virtual/net/lo'
6pack: protocol violation
kobject: 'kvm' (ffff8882194e6110): fill_kobj_path: path
= '/devices/virtual/misc/kvm'
kobject: 'loop5' (ffff8880a416cee0): kobject_uevent_env
6pack: protocol violation
kobject: 'queues' (ffff888059d85648): kobject_add_internal: parent: 'lo',
set: '<NULL>'
6pack: protocol violation
kobject: 'loop5' (ffff8880a416cee0): fill_kobj_path: path
= '/devices/virtual/block/loop5'
6pack: protocol violation
6pack: bad checksum 21
kobject: 'queues' (ffff888059d85648): kobject_uevent_env
6pack: protocol violation
kobject: 'queues' (ffff888059d85648): kobject_uevent_env: filter function
caused the event to drop!
kobject: 'kvm' (ffff8882194e6110): kobject_uevent_env
kobject: 'kvm' (ffff8882194e6110): fill_kobj_path: path
= '/devices/virtual/misc/kvm'
kobject: 'rx-0' (ffff8880a9e7cd90): kobject_add_internal: parent: 'queues',
set: 'queues'
6pack: protocol violation
kobject: 'loop3' (ffff8880a407a560): kobject_uevent_env
kauditd_printk_skb: 72 callbacks suppressed
audit: type=1400 audit(1575830533.259:5143): avc: denied { create } for
pid=13100 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=netlink_generic_socket permissive=1
kobject: 'rx-0' (ffff8880a9e7cd90): kobject_uevent_env
6pack: protocol violation
6pack: bad checksum a8
kobject: 'loop3' (ffff8880a407a560): fill_kobj_path: path
= '/devices/virtual/block/loop3'
6pack: bad checksum 02
kobject: 'kvm' (ffff8882194e6110): kobject_uevent_env
kobject: 'kvm' (ffff8882194e6110): fill_kobj_path: path
= '/devices/virtual/misc/kvm'
kobject: 'rx-0' (ffff8880a9e7cd90): fill_kobj_path: path
= '/devices/virtual/net/lo/queues/rx-0'
6pack: protocol violation
kobject: 'loop4' (ffff8880a40f45e0): kobject_uevent_env
audit: type=1400 audit(1575830533.259:5144): avc: denied { write } for
pid=13100 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=netlink_generic_socket permissive=1
6pack: protocol violation
kobject: 'loop4' (ffff8880a40f45e0): fill_kobj_path: path
= '/devices/virtual/block/loop4'
kobject: 'tx-0' (ffff88808a3a4818): kobject_add_internal: parent: 'queues',
set: 'queues'
kobject: 'loop2' (ffff8880a40624e0): kobject_uevent_env
6pack: protocol violation
kobject: 'loop2' (ffff8880a40624e0): fill_kobj_path: path
= '/devices/virtual/block/loop2'
6pack: protocol violation
6pack: protocol violation
kobject: 'tx-0' (ffff88808a3a4818): kobject_uevent_env
6pack: protocol violation
kobject: 'tx-0' (ffff88808a3a4818): fill_kobj_path: path
= '/devices/virtual/net/lo/queues/tx-0'
kobject: 'loop4' (ffff8880a40f45e0): kobject_uevent_env
6pack: protocol violation
audit: type=1400 audit(1575830533.259:5145): avc: denied { read } for
pid=13100 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=netlink_generic_socket permissive=1
6pack: protocol violation
kobject: 'loop4' (ffff8880a40f45e0): fill_kobj_path: path
= '/devices/virtual/block/loop4'
audit: type=1400 audit(1575830533.369:5146): avc: denied { map } for
pid=13115 comm="modprobe" path="/bin/kmod" dev="sda1" ino=1440
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
kobject: 'loop5' (ffff8880a416cee0): kobject_uevent_env
6pack: protocol violation
6pack: protocol violation
audit: type=1400 audit(1575830533.379:5147): avc: denied { map } for
pid=13115 comm="modprobe" path="/bin/kmod" dev="sda1" ino=1440
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
audit: type=1400 audit(1575830533.389:5148): avc: denied { map } for
pid=13115 comm="modprobe" path="/lib/x86_64-linux-gnu/libkmod.so.2.1.3"
dev="sda1" ino=2811 scontext=system_u:system_r:kernel_t:s0
tcontext=system_u:object_r:file_t:s0 tclass=file permissive=1
kobject: 'loop5' (ffff8880a416cee0): fill_kobj_path: path
= '/devices/virtual/block/loop5'
audit: type=1400 audit(1575830533.429:5149): avc: denied { map } for
pid=13040 comm="ifup" path="/sbin/ifup" dev="sda1" ino=16080
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
6pack: protocol violation
audit: type=1400 audit(1575830533.459:5150): avc: denied { map } for
pid=13117 comm="modprobe" path="/bin/kmod" dev="sda1" ino=1440
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
kobject: 'loop5' (ffff8880a416cee0): kobject_uevent_env
6pack: protocol violation
6pack: protocol violation
6pack: protocol violation
audit: type=1400 audit(1575830533.609:5151): avc: denied { map } for
pid=13118 comm="blkid" path="/sbin/blkid" dev="sda1" ino=16128
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
6pack: bad checksum 35
audit: type=1400 audit(1575830533.699:5152): avc: denied { map } for
pid=13045 comm="ifdown" path="/sbin/ifdown" dev="sda1" ino=16080
scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0
tclass=file permissive=1
kobject: 'loop5' (ffff8880a416cee0): fill_kobj_path: path
= '/devices/virtual/block/loop5'
6pack: protocol violation
6pack: protocol violation
6pack: protocol violation
6pack: bad checksum 0c
kobject: 'loop3' (ffff8880a407a560): kobject_uevent_env
6pack: bad checksum 3c
6pack: bad checksum 2b
kobject: 'loop3' (ffff8880a407a560): fill_kobj_path: path
= '/devices/virtual/block/loop3'
6pack: bad checksum 20
6pack: protocol violation
6pack: protocol violation
6pack: bad checksum 07
---[ end trace b8b55be40bbdd73b ]---
6pack: bad checksum 1d
6pack: protocol violation


---
This bug is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this bug report. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

syzbot

unread,
Dec 8, 2019, 2:12:09 PM12/8/19
to syzkaller...@googlegroups.com
syzbot has found a reproducer for the following crash on:

HEAD commit: a844dc4c Linux 4.14.158
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=175aadb1e00000
kernel config: https://syzkaller.appspot.com/x/.config?x=c02bef505ffc02ff
dashboard link: https://syzkaller.appspot.com/bug?extid=bda828feeef0b6e68e3c
compiler: gcc (GCC) 9.0.0 20181231 (experimental)
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=1079f97ee00000

IMPORTANT: if you fix the bug, please add the following tag to the commit:
Reported-by: syzbot+bda828...@syzkaller.appspotmail.com

sp0: Synchronizing with TNC
sp0: Found TNC
sp0: Synchronizing with TNC
sp0: Found TNC
------------[ cut here ]------------
kernel BUG at kernel/time/timer.c:1089!
invalid opcode: 0000 [#1] PREEMPT SMP KASAN
Modules linked in:
CPU: 0 PID: 2201 Comm: kworker/u4:3 Not tainted 4.14.158-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS
Google 01/01/2011
Workqueue: events_unbound flush_to_ldisc
task: ffff8880a400a480 task.stack: ffff8880a4018000
RIP: 0010:add_timer kernel/time/timer.c:1089 [inline]
RIP: 0010:add_timer+0x689/0xae0 kernel/time/timer.c:1087
RSP: 0018:ffff8880a401fb38 EFLAGS: 00010297
RAX: ffff8880a400a480 RBX: ffff8880a401fba8 RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffff8880a400ad78 RDI: ffff8880a506f388
RBP: ffff8880a401fbd0 R08: ffff8880a400a480 R09: ffff8880a400ad98
R10: 0000000000000000 R11: 0000000000000000 R12: ffff8880a506f380
R13: dffffc0000000000 R14: ffff8880876e8f4b R15: ffff8880a506f380
FS: 0000000000000000(0000) GS:ffff8880aec00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000000250a728 CR3: 000000009111e000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
decode_prio_command drivers/net/hamradio/6pack.c:934 [inline]
sixpack_decode drivers/net/hamradio/6pack.c:1003 [inline]
sixpack_receive_buf drivers/net/hamradio/6pack.c:458 [inline]
sixpack_receive_buf+0xc9a/0x1170 drivers/net/hamradio/6pack.c:435
tty_ldisc_receive_buf+0x14d/0x1a0 drivers/tty/tty_buffer.c:459
tty_port_default_receive_buf+0x73/0xa0 drivers/tty/tty_port.c:37
receive_buf drivers/tty/tty_buffer.c:475 [inline]
flush_to_ldisc+0x1ec/0x400 drivers/tty/tty_buffer.c:527
process_one_work+0x863/0x1600 kernel/workqueue.c:2114
worker_thread+0x5d9/0x1050 kernel/workqueue.c:2248
kthread+0x319/0x430 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Code: 84 8a 00 00 00 e8 c8 10 0d 00 65 ff 0d 61 af b1 7e 0f 85 3c fd ff ff
e8 b6 10 0d 00 e8 05 04 b0 ff e9 2d fd ff ff e8 a7 10 0d 00 <0f> 0b e8 a0
10 0d 00 49 c7 c5 80 4a 02 00 e8 14 b3 ba 01 48 ba
RIP: add_timer kernel/time/timer.c:1089 [inline] RSP: ffff8880a401fb38
RIP: add_timer+0x689/0xae0 kernel/time/timer.c:1087 RSP: ffff8880a401fb38
---[ end trace fc61a135649e23c6 ]---

syzbot

unread,
Dec 9, 2019, 10:24:10 AM12/9/19
to syzkaller...@googlegroups.com
syzbot has found a reproducer for the following crash on:

HEAD commit: a844dc4c Linux 4.14.158
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=1062b82ee00000
kernel config: https://syzkaller.appspot.com/x/.config?x=c02bef505ffc02ff
dashboard link: https://syzkaller.appspot.com/bug?extid=bda828feeef0b6e68e3c
compiler: gcc (GCC) 9.0.0 20181231 (experimental)
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=15a4442ee00000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=1766f42ae00000

IMPORTANT: if you fix the bug, please add the following tag to the commit:
Reported-by: syzbot+bda828...@syzkaller.appspotmail.com

sp0: Synchronizing with TNC
sp1: Synchronizing with TNC
sp0: Found TNC
sp1: Found TNC
------------[ cut here ]------------
kernel BUG at kernel/time/timer.c:1089!
invalid opcode: 0000 [#1] PREEMPT SMP KASAN
Modules linked in:
CPU: 0 PID: 320 Comm: kworker/u4:3 Not tainted 4.14.158-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS
Google 01/01/2011
Workqueue: events_unbound flush_to_ldisc
task: ffff8880a900a380 task.stack: ffff8880a9010000
RIP: 0010:add_timer kernel/time/timer.c:1089 [inline]
RIP: 0010:add_timer+0x689/0xae0 kernel/time/timer.c:1087
RSP: 0018:ffff8880a9017b38 EFLAGS: 00010297
RAX: ffff8880a900a380 RBX: ffff8880a9017ba8 RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffff8880a900ac78 RDI: ffff88807408ef08
RBP: ffff8880a9017bd0 R08: ffff8880a900a380 R09: ffff8880a900ac98
R10: 0000000000000000 R11: 0000000000000000 R12: ffff88807408ef00
R13: dffffc0000000000 R14: ffff88808e1d6af1 R15: ffff88807408ef00
FS: 0000000000000000(0000) GS:ffff8880aec00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007faa858c29de CR3: 0000000089d73000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
decode_prio_command drivers/net/hamradio/6pack.c:934 [inline]
sixpack_decode drivers/net/hamradio/6pack.c:1003 [inline]
sixpack_receive_buf drivers/net/hamradio/6pack.c:458 [inline]
sixpack_receive_buf+0xc9a/0x1170 drivers/net/hamradio/6pack.c:435
tty_ldisc_receive_buf+0x14d/0x1a0 drivers/tty/tty_buffer.c:459
tty_port_default_receive_buf+0x73/0xa0 drivers/tty/tty_port.c:37
receive_buf drivers/tty/tty_buffer.c:475 [inline]
flush_to_ldisc+0x1ec/0x400 drivers/tty/tty_buffer.c:527
process_one_work+0x863/0x1600 kernel/workqueue.c:2114
worker_thread+0x5d9/0x1050 kernel/workqueue.c:2248
kthread+0x319/0x430 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Code: 84 8a 00 00 00 e8 c8 10 0d 00 65 ff 0d 61 af b1 7e 0f 85 3c fd ff ff
e8 b6 10 0d 00 e8 05 04 b0 ff e9 2d fd ff ff e8 a7 10 0d 00 <0f> 0b e8 a0
10 0d 00 49 c7 c5 80 4a 02 00 e8 14 b3 ba 01 48 ba
RIP: add_timer kernel/time/timer.c:1089 [inline] RSP: ffff8880a9017b38
RIP: add_timer+0x689/0xae0 kernel/time/timer.c:1087 RSP: ffff8880a9017b38
kobject: 'sp0' (ffff8880a46205b0): kobject_add_internal: parent: 'net',
set: 'devices'
kobject: 'sp0' (ffff8880a46205b0): kobject_uevent_env
kobject: 'sp0' (ffff8880a46205b0): fill_kobj_path: path
= '/devices/virtual/net/sp0'
kobject: 'queues' (ffff8880a09ddc48): kobject_add_internal: parent: 'sp0',
set: '<NULL>'
kobject: 'queues' (ffff8880a09ddc48): kobject_uevent_env
kobject: 'queues' (ffff8880a09ddc48): kobject_uevent_env: filter function
caused the event to drop!
kobject: 'rx-0' (ffff88809fea1190): kobject_add_internal: parent: 'queues',
set: 'queues'
kobject: 'rx-0' (ffff88809fea1190): kobject_uevent_env
kobject: 'rx-0' (ffff88809fea1190): fill_kobj_path: path
= '/devices/virtual/net/sp0/queues/rx-0'
kobject: 'tx-0' (ffff88809ff89d58): kobject_add_internal: parent: 'queues',
set: 'queues'
kobject: 'tx-0' (ffff88809ff89d58): kobject_uevent_env
kobject: 'tx-0' (ffff88809ff89d58): fill_kobj_path: path
= '/devices/virtual/net/sp0/queues/tx-0'
kobject: 'sp2' (ffff888095ca9270): kobject_add_internal: parent: 'net',
set: 'devices'
sp0: Synchronizing with TNC
kobject: 'sp2' (ffff888095ca9270): kobject_uevent_env
---[ end trace 5228ba54d8f8ea05 ]---
6pack: protocol violation

Reply all
Reply to author
Forward
0 new messages