BUG: MAX_LOCKDEP_CHAINS too low! turning off the locking correctness validator. CPU: 0 PID: 16514 Comm: syz-executor.4 Not tainted 4.14.226-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 add_chain_cache kernel/locking/lockdep.c:2303 [inline] lookup_chain_cache_add kernel/locking/lockdep.c:2415 [inline] validate_chain kernel/locking/lockdep.c:2435 [inline] __lock_acquire.cold+0x19a/0x97c kernel/locking/lockdep.c:3491 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 seqcount_lockdep_reader_access include/linux/seqlock.h:81 [inline] read_seqcount_begin include/linux/seqlock.h:164 [inline] ktime_get+0xbd/0x2c0 kernel/time/timekeeping.c:760 hrtimer_expires_remaining include/linux/hrtimer.h:261 [inline] __hrtimer_get_remaining+0xd7/0x1d0 kernel/time/hrtimer.c:1060 hrtimer_get_remaining include/linux/hrtimer.h:404 [inline] perf_swevent_cancel_hrtimer kernel/events/core.c:8788 [inline] perf_swevent_cancel_hrtimer kernel/events/core.c:8783 [inline] cpu_clock_event_stop kernel/events/core.c:8842 [inline] cpu_clock_event_del+0x78/0xc0 kernel/events/core.c:8857 event_sched_out+0x8b3/0x11b0 kernel/events/core.c:1867 group_sched_out+0x13e/0x3c0 kernel/events/core.c:1897 ctx_sched_out+0x4f4/0x9d0 kernel/events/core.c:2852 task_ctx_sched_out+0x5b/0x80 kernel/events/core.c:2320 perf_event_context_sched_out kernel/events/core.c:3035 [inline] __perf_event_task_sched_out+0x853/0x11d0 kernel/events/core.c:3126 perf_event_task_sched_out include/linux/perf_event.h:1104 [inline] prepare_task_switch kernel/sched/core.c:2601 [inline] context_switch kernel/sched/core.c:2773 [inline] __schedule+0xc74/0x1de0 kernel/sched/core.c:3384 preempt_schedule_irq+0xb0/0x140 kernel/sched/core.c:3611 retint_kernel+0x1b/0x2d RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline] RIP: 0010:lock_acquire+0x1ec/0x3f0 kernel/locking/lockdep.c:4001 RSP: 0018:ffff888071047998 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff02 RAX: 1ffffffff11e1259 RBX: ffff88806ef24640 RCX: 000000000000787d RDX: dffffc0000000000 RSI: 0000000000000001 RDI: 0000000000000286 RBP: ffff888095b065e0 R08: ffffffff8b9c5ea8 R09: 00000000000408a6 R10: ffff88806ef24f90 R11: ffff88806ef24640 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000001 flush_work+0xad/0x770 kernel/workqueue.c:2889 __cancel_work_timer+0x321/0x460 kernel/workqueue.c:2964 rpc_close_pipes+0x472/0x710 net/sunrpc/rpc_pipe.c:188 __rpc_rmpipe net/sunrpc/rpc_pipe.c:643 [inline] rpc_unlink+0x76/0xe0 net/sunrpc/rpc_pipe.c:869 nfs4blocklayout_unregister_sb fs/nfs/blocklayout/rpc_pipefs.c:162 [inline] rpc_pipefs_event+0x209/0x400 fs/nfs/blocklayout/rpc_pipefs.c:193 notifier_call_chain+0x108/0x1a0 kernel/notifier.c:93 __blocking_notifier_call_chain kernel/notifier.c:317 [inline] __blocking_notifier_call_chain kernel/notifier.c:304 [inline] blocking_notifier_call_chain kernel/notifier.c:328 [inline] blocking_notifier_call_chain+0x79/0x90 kernel/notifier.c:325 rpc_kill_sb+0x1e9/0x300 net/sunrpc/rpc_pipe.c:1469 deactivate_locked_super+0x6c/0xd0 fs/super.c:319 deactivate_super+0x7f/0xa0 fs/super.c:350 cleanup_mnt+0x186/0x2c0 fs/namespace.c:1183 task_work_run+0x11f/0x190 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:191 [inline] exit_to_usermode_loop+0x1ad/0x200 arch/x86/entry/common.c:164 prepare_exit_to_usermode arch/x86/entry/common.c:199 [inline] syscall_return_slowpath arch/x86/entry/common.c:270 [inline] do_syscall_64+0x4a3/0x640 arch/x86/entry/common.c:297 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x466459 RSP: 002b:00007fcead0a1188 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffec RBX: 000000000056c158 RCX: 0000000000466459 RDX: 0000000020000200 RSI: 00000000200000c0 RDI: 0000000000000000 RBP: 00000000004bf9fb R08: 0000000020000200 R09: 0000000000000000 R10: 0000000002008480 R11: 0000000000000246 R12: 000000000056c158 R13: 00007ffca73a2c1f R14: 00007fcead0a1300 R15: 0000000000022000 EXT4-fs (sda1): Delayed block allocation failed for inode 13867 at logical offset 117 with max blocks 166 with error 117 EXT4-fs (sda1): This should not happen!! Data will be lost batman_adv: batadv0: Removing interface: batadv_slave_0 batman_adv: batadv0: Removing interface: batadv_slave_1 device bridge_slave_1 left promiscuous mode bridge0: port 2(bridge_slave_1) entered disabled state device bridge_slave_0 left promiscuous mode bridge0: port 1(bridge_slave_0) entered disabled state device hsr_slave_1 left promiscuous mode device hsr_slave_0 left promiscuous mode team0 (unregistering): Port device team_slave_1 removed team0 (unregistering): Port device team_slave_0 removed bond0 (unregistering): Releasing backup interface bond_slave_1 bond0 (unregistering): Releasing backup interface bond_slave_0 bond0 (unregistering): Released all slaves BTRFS: device fsid f90cac8b-044b-4fa8-8bee-4b8d3da88dc2 devid 1 transid 7 /dev/loop5 BTRFS info (device loop5): disabling disk space caching BTRFS info (device loop5): force zlib compression BTRFS info (device loop5): turning on flush-on-commit BTRFS info (device loop5): has skinny extents BTRFS error (device loop5): open_ctree failed audit: type=1804 audit(1616232514.692:33140): pid=16737 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/918/file0/bus" dev="ramfs" ino=233233 res=1 audit: type=1804 audit(1616232514.762:33141): pid=16744 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/918/file0/file0/bus" dev="ramfs" ino=231993 res=1 audit: type=1804 audit(1616232514.832:33142): pid=16753 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/919/file0/bus" dev="ramfs" ino=232004 res=1 audit: type=1804 audit(1616232514.952:33143): pid=16762 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/920/file0/bus" dev="ramfs" ino=233272 res=1 BTRFS info (device loop5): disabling disk space caching BTRFS info (device loop5): force zlib compression BTRFS info (device loop5): turning on flush-on-commit BTRFS info (device loop5): has skinny extents audit: type=1804 audit(1616232515.682:33144): pid=16820 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/921/file0/bus" dev="ramfs" ino=232038 res=1 BTRFS info (device loop5): disabling disk space caching BTRFS info (device loop5): force zlib compression BTRFS info (device loop5): turning on flush-on-commit BTRFS info (device loop5): has skinny extents audit: type=1800 audit(1616232516.452:33145): pid=16892 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.0" name="file0" dev="sda1" ino=14291 res=0 audit: type=1804 audit(1616232516.472:33146): pid=16892 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/925/file0" dev="sda1" ino=14291 res=1 audit: type=1804 audit(1616232516.472:33147): pid=16892 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/925/file0" dev="sda1" ino=14291 res=1 audit: type=1804 audit(1616232516.492:33148): pid=16892 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/925/file0" dev="sda1" ino=14291 res=1 audit: type=1804 audit(1616232516.492:33149): pid=16892 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.0" name="/root/syzkaller-testdir922890932/syzkaller.ueqX2d/925/file0" dev="sda1" ino=14291 res=1 FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) EXT4-fs (sda1): Delayed block allocation failed for inode 13870 at logical offset 17 with max blocks 3 with error 117 EXT4-fs (sda1): This should not happen!! Data will be lost FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop5): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) FAT-fs (loop2): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1) (unnamed net_device) (uninitialized): option lp_interval: invalid value (0) (unnamed net_device) (uninitialized): option lp_interval: allowed values 1 - 2147483647 (unnamed net_device) (uninitialized): option lp_interval: invalid value (0) (unnamed net_device) (uninitialized): option lp_interval: allowed values 1 - 2147483647 (unnamed net_device) (uninitialized): option lp_interval: invalid value (0) (unnamed net_device) (uninitialized): option lp_interval: allowed values 1 - 2147483647 (unnamed net_device) (uninitialized): option lp_interval: invalid value (0) (unnamed net_device) (uninitialized): option lp_interval: allowed values 1 - 2147483647 kauditd_printk_skb: 59 callbacks suppressed audit: type=1800 audit(1616232520.302:33209): pid=17139 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.1" name="file0" dev="sda1" ino=14818 res=0 (unnamed net_device) (uninitialized): option lp_interval: invalid value (0) audit: type=1804 audit(1616232520.332:33210): pid=17139 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.1" name="/root/syzkaller-testdir887600745/syzkaller.37bJxr/1042/file0" dev="sda1" ino=14818 res=1 (unnamed net_device) (uninitialized): option lp_interval: allowed values 1 - 2147483647 audit: type=1804 audit(1616232520.342:33211): pid=17139 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.1" name="/root/syzkaller-testdir887600745/syzkaller.37bJxr/1042/file0" dev="sda1" ino=14818 res=1 audit: type=1804 audit(1616232520.422:33212): pid=17139 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.1" name="/root/syzkaller-testdir887600745/syzkaller.37bJxr/1042/file0" dev="sda1" ino=14818 res=1 audit: type=1804 audit(1616232520.422:33213): pid=17139 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.1" name="/root/syzkaller-testdir887600745/syzkaller.37bJxr/1042/file0" dev="sda1" ino=14818 res=1 audit: type=1804 audit(1616232521.242:33215): pid=17203 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir845473846/syzkaller.601qyX/1706/file0" dev="sda1" ino=15026 res=1 audit: type=1800 audit(1616232521.242:33214): pid=17188 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.3" name="file0" dev="sda1" ino=15026 res=0 audit: type=1804 audit(1616232521.272:33216): pid=17203 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.3" name="/root/syzkaller-testdir845473846/syzkaller.601qyX/1706/file0" dev="sda1" ino=15026 res=1 audit: type=1804 audit(1616232521.962:33217): pid=17255 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.3" name="/root/syzkaller-testdir845473846/syzkaller.601qyX/1706/file0" dev="sda1" ino=15026 res=1 audit: type=1804 audit(1616232521.982:33218): pid=17256 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir845473846/syzkaller.601qyX/1706/file0" dev="sda1" ino=15026 res=1