BUG: sleeping function called from invalid context in alloc_buffer_head BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 2936, name: jbd2/sda1-8 preempt_count: 0, expected: 0 RCU nest depth: 0, expected: 0 no locks held by jbd2/sda1-8/2936. irq event stamp: 1892 hardirqs last enabled at (1891): [] __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:159 [inline] hardirqs last enabled at (1891): [] _raw_spin_unlock_irq+0x1f/0x40 kernel/locking/spinlock.c:202 hardirqs last disabled at (1892): [] slab_alloc mm/slab.c:3278 [inline] hardirqs last disabled at (1892): [] __kmem_cache_alloc_lru mm/slab.c:3475 [inline] hardirqs last disabled at (1892): [] kmem_cache_alloc+0x3e1/0x590 mm/slab.c:3495 softirqs last enabled at (1752): [] invoke_softirq kernel/softirq.c:445 [inline] softirqs last enabled at (1752): [] __irq_exit_rcu+0x123/0x180 kernel/softirq.c:650 softirqs last disabled at (1737): [] invoke_softirq kernel/softirq.c:445 [inline] softirqs last disabled at (1737): [] __irq_exit_rcu+0x123/0x180 kernel/softirq.c:650 CPU: 1 PID: 2936 Comm: jbd2/sda1-8 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 Call Trace: __dump_stack lib/dump_stack.c:88 [inline] dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106 __might_resched.cold+0x222/0x26b kernel/sched/core.c:9892 might_alloc include/linux/sched/mm.h:274 [inline] slab_pre_alloc_hook mm/slab.h:700 [inline] slab_alloc mm/slab.c:3279 [inline] __kmem_cache_alloc_lru mm/slab.c:3475 [inline] kmem_cache_alloc+0x3d2/0x590 mm/slab.c:3495 kmem_cache_zalloc include/linux/slab.h:723 [inline] alloc_buffer_head+0x20/0x140 fs/buffer.c:2974 alloc_page_buffers+0x280/0x790 fs/buffer.c:829 grow_dev_page fs/buffer.c:965 [inline] grow_buffers fs/buffer.c:1011 [inline] __getblk_slow+0x4fe/0x1030 fs/buffer.c:1038 __getblk_gfp+0x6e/0x80 fs/buffer.c:1333 __getblk include/linux/buffer_head.h:418 [inline] jbd2_journal_get_descriptor_buffer+0x10a/0x410 fs/jbd2/journal.c:1013 jbd2_journal_commit_transaction+0x221d/0x6a40 fs/jbd2/commit.c:647 kjournald2+0x1d0/0x930 fs/jbd2/journal.c:210 kthread+0x2e4/0x3a0 kernel/kthread.c:376 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306 [ 58.164102][ T2936] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 58.173701][ T2936] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 2936, name: jbd2/sda1-8 [ 58.183295][ T2936] preempt_count: 0, expected: 0 [ 58.188161][ T2936] RCU nest depth: 0, expected: 0 [ 58.193311][ T2936] no locks held by jbd2/sda1-8/2936. [ 58.198681][ T2936] irq event stamp: 1892 [ 58.202830][ T2936] hardirqs last enabled at (1891): [] _raw_spin_unlock_irq+0x1f/0x40 [ 58.212582][ T2936] hardirqs last disabled at (1892): [] kmem_cache_alloc+0x3e1/0x590 [ 58.222147][ T2936] softirqs last enabled at (1752): [] __irq_exit_rcu+0x123/0x180 [ 58.231627][ T2936] softirqs last disabled at (1737): [] __irq_exit_rcu+0x123/0x180 [ 58.241014][ T2936] CPU: 1 PID: 2936 Comm: jbd2/sda1-8 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 58.253376][ T2936] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 58.263916][ T2936] Call Trace: [ 58.267204][ T2936] [ 58.270158][ T2936] dump_stack_lvl+0xcd/0x134 [ 58.274770][ T2936] __might_resched.cold+0x222/0x26b [ 58.280129][ T2936] kmem_cache_alloc+0x3d2/0x590 [ 58.285006][ T2936] alloc_buffer_head+0x20/0x140 [ 58.290055][ T2936] alloc_page_buffers+0x280/0x790 [ 58.295113][ T2936] __getblk_slow+0x4fe/0x1030 [ 58.299798][ T2936] __getblk_gfp+0x6e/0x80 [ 58.304227][ T2936] jbd2_journal_get_descriptor_buffer+0x10a/0x410 [ 58.310647][ T2936] ? do_raw_write_lock+0x11a/0x280 [ 58.315828][ T2936] ? jbd2_journal_flush+0xc00/0xc00 [ 58.321055][ T2936] jbd2_journal_commit_transaction+0x221d/0x6a40 [ 58.327473][ T2936] ? jbd2_journal_finish_inode_data_buffers+0xc0/0xc0 [ 58.334339][ T2936] ? find_held_lock+0x2d/0x110 [ 58.339153][ T2936] ? try_to_del_timer_sync+0xbf/0x110 [ 58.344580][ T2936] ? _raw_spin_unlock_irqrestore+0x50/0x70 [ 58.350390][ T2936] ? lockdep_hardirqs_on+0x79/0x100 [ 58.355856][ T2936] ? del_timer_sync+0x17e/0x1b0 [ 58.360748][ T2936] ? del_timer_sync+0x17e/0x1b0 [ 58.365611][ T2936] kjournald2+0x1d0/0x930 [ 58.369947][ T2936] ? jbd2_journal_init_inode+0x3b0/0x3b0 [ 58.375757][ T2936] ? _raw_spin_unlock_irqrestore+0x50/0x70 [ 58.381570][ T2936] ? prepare_to_wait_exclusive+0x2b0/0x2b0 [ 58.387380][ T2936] ? __kthread_parkme+0x15f/0x220 [ 58.392419][ T2936] ? jbd2_journal_init_inode+0x3b0/0x3b0 [ 58.398054][ T2936] kthread+0x2e4/0x3a0 [ 58.402148][ T2936] ? kthread_complete_and_exit+0x40/0x40 [ 58.408071][ T2936] ret_from_fork+0x1f/0x30 [ 58.412598][ T2936] [ 62.413263][ T3281] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 62.423136][ T3281] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3281, name: sshd [ 62.432003][ T3281] preempt_count: 0, expected: 0 [ 62.436893][ T3281] RCU nest depth: 0, expected: 0 [ 62.441828][ T3281] no locks held by sshd/3281. [ 62.446600][ T3281] irq event stamp: 7688 [ 62.450768][ T3281] hardirqs last enabled at (7687): [] syscall_enter_from_user_mode+0x22/0xb0 [ 62.461199][ T3281] hardirqs last disabled at (7688): [] kmem_cache_alloc_lru+0x488/0x900 [ 62.471302][ T3281] softirqs last enabled at (7646): [] __fpu_restore_sig+0x5e8/0x1320 [ 62.481030][ T3281] softirqs last disabled at (7644): [] __fpu_restore_sig+0x388/0x1320 [ 62.490762][ T3281] CPU: 1 PID: 3281 Comm: sshd Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 62.502388][ T3281] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 62.512878][ T3281] Call Trace: [ 62.516156][ T3281] [ 62.519263][ T3281] dump_stack_lvl+0xcd/0x134 [ 62.523946][ T3281] __might_resched.cold+0x222/0x26b [ 62.529235][ T3281] kmem_cache_alloc_lru+0x479/0x900 [ 62.534483][ T3281] sock_alloc_inode+0x23/0x1d0 [ 62.539278][ T3281] ? sock_free_inode+0x20/0x20 [ 62.544043][ T3281] alloc_inode+0x61/0x230 [ 62.548385][ T3281] new_inode_pseudo+0x13/0x80 [ 62.553076][ T3281] sock_alloc+0x3c/0x260 [ 62.557324][ T3281] do_accept+0x13b/0x510 [ 62.561581][ T3281] ? do_raw_spin_lock+0x120/0x2a0 [ 62.566615][ T3281] ? __ia32_sys_listen+0x70/0x70 [ 62.571557][ T3281] ? rwlock_bug.part.0+0x90/0x90 [ 62.576583][ T3281] ? _find_next_bit+0x1e3/0x260 [ 62.581436][ T3281] ? do_raw_spin_unlock+0x171/0x230 [ 62.586730][ T3281] ? _raw_spin_unlock+0x24/0x40 [ 62.591685][ T3281] ? alloc_fd+0x2f0/0x6f0 [ 62.596196][ T3281] __sys_accept4+0x96/0x120 [ 62.600706][ T3281] __x64_sys_accept+0x71/0xb0 [ 62.605389][ T3281] do_syscall_64+0x35/0xb0 [ 62.609905][ T3281] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 62.615817][ T3281] RIP: 0033:0x7f49f96b9c53 [ 62.620251][ T3281] Code: 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 64 8b 04 25 18 00 00 00 85 c0 75 14 b8 2b 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 55 c3 0f 1f 40 00 48 83 ec 28 48 89 54 24 18 [ 62.639991][ T3281] RSP: 002b:00007fff557276a8 EFLAGS: 00000246 ORIG_RAX: 000000000000002b [ 62.648415][ T3281] RAX: ffffffffffffffda RBX: 000055966aff94c0 RCX: 00007f49f96b9c53 [ 62.656394][ T3281] RDX: 00007fff55727710 RSI: 00007fff55727728 RDI: 0000000000000003 [ 62.664451][ T3281] RBP: 0000000000000000 R08: 000055966c1febb0 R09: 00007fff55727680 [ 62.673136][ T3281] R10: 0000000000000008 R11: 0000000000000246 R12: 0000000000000064 [ 62.681117][ T3281] R13: 000055966c1febb0 R14: 000000000000018c R15: 000055966afa9e85 [ 62.689179][ T3281] Warning: Permanently added '10.128.0.249' (ECDSA) to the list of known hosts. 2022/09/28 08:44:30 fuzzer started 2022/09/28 08:44:30 connecting to host at 10.128.0.169:44565 2022/09/28 08:44:30 checking machine... 2022/09/28 08:44:30 checking revisions... [ 63.424294][ T3610] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 63.433821][ T3610] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3610, name: syz-fuzzer [ 63.442858][ T3610] preempt_count: 0, expected: 0 [ 63.447823][ T3610] RCU nest depth: 0, expected: 0 [ 63.452764][ T3610] no locks held by syz-fuzzer/3610. [ 63.458135][ T3610] irq event stamp: 48996 [ 63.462461][ T3610] hardirqs last enabled at (48995): [] syscall_enter_from_user_mode+0x22/0xb0 [ 63.473067][ T3610] hardirqs last disabled at (48996): [] kmem_cache_alloc+0x3e1/0x590 [ 63.482803][ T3610] softirqs last enabled at (48972): [] __irq_exit_rcu+0x123/0x180 [ 63.492279][ T3610] softirqs last disabled at (48965): [] __irq_exit_rcu+0x123/0x180 [ 63.501742][ T3610] CPU: 0 PID: 3610 Comm: syz-fuzzer Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 63.514006][ T3610] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 63.524348][ T3610] Call Trace: [ 63.527994][ T3610] [ 63.530929][ T3610] dump_stack_lvl+0xcd/0x134 [ 63.535535][ T3610] __might_resched.cold+0x222/0x26b [ 63.540824][ T3610] kmem_cache_alloc+0x3d2/0x590 [ 63.545682][ T3610] getname_flags.part.0+0x50/0x4f0 [ 63.550810][ T3610] getname_flags+0x9a/0xe0 [ 63.555228][ T3610] vfs_fstatat+0x73/0xb0 [ 63.559477][ T3610] __do_sys_newfstatat+0x91/0x110 [ 63.564504][ T3610] ? __do_compat_sys_newlstat+0x110/0x110 [ 63.570316][ T3610] ? up_write+0x470/0x470 [ 63.574835][ T3610] ? syscall_enter_from_user_mode+0x22/0xb0 [ 63.580730][ T3610] ? syscall_enter_from_user_mode+0x22/0xb0 [ 63.586713][ T3610] do_syscall_64+0x35/0xb0 [ 63.591136][ T3610] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 63.597034][ T3610] RIP: 0033:0x49e02a [ 63.600927][ T3610] Code: e8 5b 8f fc ff 48 8b 7c 24 10 48 8b 74 24 18 48 8b 54 24 20 4c 8b 54 24 28 4c 8b 44 24 30 4c 8b 4c 24 38 48 8b 44 24 08 0f 05 <48> 3d 01 f0 ff ff 76 20 48 c7 44 24 40 ff ff ff ff 48 c7 44 24 48 [ 63.620535][ T3610] RSP: 002b:000000c0005d13d8 EFLAGS: 00000212 ORIG_RAX: 0000000000000106 [ 63.628955][ T3610] RAX: ffffffffffffffda RBX: 000000c000020000 RCX: 000000000049e02a [ 63.637015][ T3610] RDX: 000000c00008e038 RSI: 000000c0000140a0 RDI: ffffffffffffff9c [ 63.645008][ T3610] RBP: 000000c0005d1468 R08: 0000000000000000 R09: 0000000000000000 [ 63.653009][ T3610] R10: 0000000000000000 R11: 0000000000000212 R12: 000000c0000140a0 [ 63.660988][ T3610] R13: 0000000000000001 R14: 000000c0000001a0 R15: 00007f06595be706 [ 63.669135][ T3610] [ 63.755166][ T27] audit: type=1400 audit(1664354671.162:76): avc: denied { getattr } for pid=3606 comm="syz-fuzzer" path="user:[4026531837]" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 63.778956][ T27] audit: type=1400 audit(1664354671.162:77): avc: denied { read } for pid=3606 comm="syz-fuzzer" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 2022/09/28 08:44:31 testing simple program... [ 63.800910][ T27] audit: type=1400 audit(1664354671.162:78): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="user:[4026531837]" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 63.828689][ T27] audit: type=1400 audit(1664354671.232:79): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="raw-gadget" dev="devtmpfs" ino=730 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:device_t tclass=chr_file permissive=1 [ 63.852389][ T27] audit: type=1400 audit(1664354671.232:80): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/raw-gadget" dev="devtmpfs" ino=730 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:device_t tclass=chr_file permissive=1 [ 63.863577][ T3615] cgroup: Unknown subsys name 'net' [ 63.876060][ T27] audit: type=1400 audit(1664354671.232:81): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="vhci" dev="devtmpfs" ino=1074 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:vhost_device_t tclass=chr_file permissive=1 [ 63.904138][ T27] audit: type=1400 audit(1664354671.232:82): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/vhci" dev="devtmpfs" ino=1074 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:vhost_device_t tclass=chr_file permissive=1 [ 63.927643][ T27] audit: type=1400 audit(1664354671.262:83): avc: denied { mounton } for pid=3615 comm="syz-executor" path="/syzcgroup/unified" dev="sda1" ino=1136 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:root_t tclass=dir permissive=1 [ 63.950759][ T27] audit: type=1400 audit(1664354671.262:84): avc: denied { mount } for pid=3615 comm="syz-executor" name="/" dev="cgroup2" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cgroup_t tclass=filesystem permissive=1 [ 63.973107][ T27] audit: type=1400 audit(1664354671.282:85): avc: denied { unmount } for pid=3615 comm="syz-executor" scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cgroup_t tclass=filesystem permissive=1 [ 64.122139][ T3615] cgroup: Unknown subsys name 'rlimit' [ 65.365163][ T3616] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 65.374850][ T3616] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3616, name: kworker/1:3 [ 65.383981][ T3616] preempt_count: 0, expected: 0 [ 65.388833][ T3616] RCU nest depth: 0, expected: 0 [ 65.393764][ T3616] 3 locks held by kworker/1:3/3616: [ 65.398992][ T3616] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 65.409461][ T3616] #1: ffffc90003087da8 ((work_completion)(&(&data->open_timeout)->work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 65.422200][ T3616] #2: ffff88802107f918 (&data->open_mutex){+.+.}-{3:3}, at: vhci_open_timeout+0x2d/0x50 [ 65.432142][ T3616] irq event stamp: 1624 [ 65.436297][ T3616] hardirqs last enabled at (1623): [] _raw_spin_unlock_irqrestore+0x50/0x70 [ 65.446628][ T3616] hardirqs last disabled at (1624): [] __kmalloc+0x3b6/0x510 [ 65.455580][ T3616] softirqs last enabled at (1570): [] process_one_work+0x991/0x1610 [ 65.465237][ T3616] softirqs last disabled at (1566): [] neigh_managed_work+0x35/0x250 [ 65.474894][ T3616] CPU: 1 PID: 3616 Comm: kworker/1:3 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 65.486959][ T3616] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 65.497018][ T3616] Workqueue: events vhci_open_timeout [ 65.502409][ T3616] Call Trace: [ 65.505781][ T3616] [ 65.508717][ T3616] dump_stack_lvl+0xcd/0x134 [ 65.513491][ T3616] __might_resched.cold+0x222/0x26b [ 65.518959][ T3616] __kmalloc+0x3a7/0x510 [ 65.523383][ T3616] ? hci_alloc_dev_priv+0x1e/0x2570 [ 65.528589][ T3616] hci_alloc_dev_priv+0x1e/0x2570 [ 65.533804][ T3616] __vhci_create_device+0xf9/0x7d0 [ 65.538930][ T3616] vhci_open_timeout+0x38/0x50 [ 65.543704][ T3616] process_one_work+0x991/0x1610 [ 65.548647][ T3616] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 65.554033][ T3616] ? rwlock_bug.part.0+0x90/0x90 [ 65.558981][ T3616] ? _raw_spin_lock_irq+0x41/0x50 [ 65.564011][ T3616] worker_thread+0x665/0x1080 [ 65.570262][ T3616] ? __kthread_parkme+0x15f/0x220 [ 65.575415][ T3616] ? process_one_work+0x1610/0x1610 [ 65.580617][ T3616] kthread+0x2e4/0x3a0 [ 65.584700][ T3616] ? kthread_complete_and_exit+0x40/0x40 [ 65.590423][ T3616] ret_from_fork+0x1f/0x30 [ 65.594872][ T3616] [ 65.618547][ T3619] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 65.626993][ T3619] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 65.634957][ T3619] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 65.642778][ T3619] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 65.650644][ T3622] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 65.658929][ T3622] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 65.779483][ T3618] chnl_net:caif_netlink_parms(): no params data found [ 65.829760][ T3618] bridge0: port 1(bridge_slave_0) entered blocking state [ 65.838049][ T3618] bridge0: port 1(bridge_slave_0) entered disabled state [ 65.846427][ T3618] device bridge_slave_0 entered promiscuous mode [ 65.856640][ T3618] bridge0: port 2(bridge_slave_1) entered blocking state [ 65.863930][ T3618] bridge0: port 2(bridge_slave_1) entered disabled state [ 65.871709][ T3618] device bridge_slave_1 entered promiscuous mode [ 65.896043][ T3618] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 65.907646][ T3618] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 65.932647][ T3618] team0: Port device team_slave_0 added [ 65.940787][ T3618] team0: Port device team_slave_1 added [ 65.960554][ T3618] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 65.967739][ T3618] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 65.994434][ T3618] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 66.007491][ T3618] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 66.014603][ T3618] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 66.040697][ T3618] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 66.071851][ T3618] device hsr_slave_0 entered promiscuous mode [ 66.079447][ T3618] device hsr_slave_1 entered promiscuous mode [ 66.180282][ T3618] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 66.191060][ T3618] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 66.201496][ T3618] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 66.212218][ T3618] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 66.237462][ T3618] bridge0: port 2(bridge_slave_1) entered blocking state [ 66.244905][ T3618] bridge0: port 2(bridge_slave_1) entered forwarding state [ 66.253066][ T3618] bridge0: port 1(bridge_slave_0) entered blocking state [ 66.260258][ T3618] bridge0: port 1(bridge_slave_0) entered forwarding state executing program [ 66.310961][ T3618] 8021q: adding VLAN 0 to HW filter on device bond0 [ 66.326276][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 66.338097][ T6] bridge0: port 1(bridge_slave_0) entered disabled state [ 66.348313][ T6] bridge0: port 2(bridge_slave_1) entered disabled state [ 66.356841][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 66.364349][ T6] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 66.374619][ T6] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 6, name: kworker/0:0 [ 66.383589][ T6] preempt_count: 0, expected: 0 [ 66.388457][ T6] RCU nest depth: 0, expected: 0 [ 66.393512][ T6] 3 locks held by kworker/0:0/6: [ 66.398450][ T6] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 66.409299][ T6] #1: ffffc900002cfda8 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 66.419703][ T6] #2: ffffffff8d7a8928 (rtnl_mutex){+.+.}-{3:3}, at: linkwatch_event+0xb/0x60 [ 66.428691][ T6] irq event stamp: 566512 [ 66.433099][ T6] hardirqs last enabled at (566511): [] mod_delayed_work_on+0x19f/0x220 [ 66.443608][ T6] hardirqs last disabled at (566512): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 66.454232][ T6] softirqs last enabled at (566502): [] __irq_exit_rcu+0x123/0x180 [ 66.463888][ T6] softirqs last disabled at (566475): [] __irq_exit_rcu+0x123/0x180 [ 66.473551][ T6] CPU: 0 PID: 6 Comm: kworker/0:0 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 66.485358][ T6] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 66.495591][ T6] Workqueue: events linkwatch_event [ 66.500896][ T6] Call Trace: [ 66.504204][ T6] [ 66.507140][ T6] dump_stack_lvl+0xcd/0x134 [ 66.511825][ T6] __might_resched.cold+0x222/0x26b [ 66.517400][ T6] kmem_cache_alloc_trace+0x36f/0x4d0 [ 66.522798][ T6] fib6_info_alloc+0xc1/0x210 [ 66.527841][ T6] ip6_route_info_create+0x33e/0x1aa0 [ 66.533222][ T6] ? fib6_nh_init+0x1be0/0x1be0 [ 66.538093][ T6] ? lock_downgrade+0x6e0/0x6e0 [ 66.543137][ T6] ip6_route_add+0x24/0x150 [ 66.547744][ T6] addrconf_add_mroute+0x1e1/0x310 [ 66.553123][ T6] ? addrconf_sysctl_disable_policy+0x610/0x610 [ 66.559558][ T6] addrconf_add_dev+0x156/0x1c0 [ 66.564774][ T6] addrconf_dev_config+0x1ec/0x410 [ 66.569904][ T6] addrconf_notify+0xf36/0x1c10 [ 66.574942][ T6] ? clusterip_netdev_event+0x419/0x650 [ 66.580510][ T6] ? tee_netdev_event+0x3bc/0x5c0 [ 66.585547][ T6] ? ip6mr_device_event+0x1ab/0x220 [ 66.590752][ T6] notifier_call_chain+0xb5/0x200 [ 66.596236][ T6] call_netdevice_notifiers_info+0xb5/0x130 [ 66.602234][ T6] netdev_state_change+0x100/0x130 [ 66.607357][ T6] ? dev_valid_name+0x70/0x70 [ 66.612042][ T6] ? _raw_write_unlock+0x24/0x40 [ 66.617165][ T6] linkwatch_do_dev+0x10e/0x150 [ 66.622108][ T6] __linkwatch_run_queue+0x23f/0x6a0 [ 66.627399][ T6] ? linkwatch_do_dev+0x150/0x150 [ 66.632431][ T6] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 66.638455][ T6] linkwatch_event+0x4a/0x60 [ 66.643049][ T6] process_one_work+0x991/0x1610 [ 66.648169][ T6] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 66.653643][ T6] ? rwlock_bug.part.0+0x90/0x90 [ 66.658584][ T6] ? _raw_spin_lock_irq+0x41/0x50 [ 66.663611][ T6] worker_thread+0x665/0x1080 [ 66.668382][ T6] ? process_one_work+0x1610/0x1610 [ 66.673681][ T6] kthread+0x2e4/0x3a0 [ 66.677800][ T6] ? kthread_complete_and_exit+0x40/0x40 [ 66.683433][ T6] ret_from_fork+0x1f/0x30 [ 66.687856][ T6] [ 66.704235][ T3618] 8021q: adding VLAN 0 to HW filter on device team0 [ 66.717959][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 66.726811][ T6] bridge0: port 1(bridge_slave_0) entered blocking state [ 66.734011][ T6] bridge0: port 1(bridge_slave_0) entered forwarding state [ 66.747103][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 66.756591][ T6] bridge0: port 2(bridge_slave_1) entered blocking state [ 66.763692][ T6] bridge0: port 2(bridge_slave_1) entered forwarding state [ 66.775935][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 66.793496][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 66.802700][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 66.814076][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 66.822623][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 66.831912][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 66.846880][ T3618] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 66.857695][ T3618] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 66.871408][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 66.879687][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 66.888591][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 66.897948][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 66.906810][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 66.925230][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 67.003389][ T3618] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 67.012278][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 67.020297][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 67.037468][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 67.049072][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 67.068170][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 67.077456][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 67.087244][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 67.096147][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 67.107801][ T3618] device veth0_vlan entered promiscuous mode [ 67.120096][ T3618] device veth1_vlan entered promiscuous mode [ 67.142705][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 67.152503][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 67.161063][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 67.170179][ T3629] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 67.181604][ T3618] device veth0_macvtap entered promiscuous mode [ 67.192298][ T3618] device veth1_macvtap entered promiscuous mode [ 67.208837][ T3618] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 67.216693][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 67.225502][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 67.233515][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 67.242740][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 67.257980][ T3618] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 67.266052][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 67.275554][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 67.289695][ T3618] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 67.299151][ T3618] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 67.308166][ T3618] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 67.317315][ T3618] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 67.364876][ T3618] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 67.374740][ T3618] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3618, name: syz-executor.0 [ 67.384263][ T3618] preempt_count: 0, expected: 0 [ 67.389125][ T3618] RCU nest depth: 0, expected: 0 [ 67.394078][ T3618] 1 lock held by syz-executor.0/3618: [ 67.399460][ T3618] #0: ffff88806970b6a0 (kn->active#180){.+.+}-{0:0}, at: kernfs_fop_open+0x9c/0xfd0 [ 67.408979][ T3618] irq event stamp: 164942 [ 67.413297][ T3618] hardirqs last enabled at (164941): [] asm_sysvec_apic_timer_interrupt+0x16/0x20 [ 67.424248][ T3618] hardirqs last disabled at (164942): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 67.434517][ T3618] softirqs last enabled at (164936): [] __irq_exit_rcu+0x123/0x180 [ 67.444078][ T3618] softirqs last disabled at (164921): [] __irq_exit_rcu+0x123/0x180 [ 67.453642][ T3618] CPU: 0 PID: 3618 Comm: syz-executor.0 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 67.465988][ T3618] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 67.476276][ T3618] Call Trace: [ 67.479571][ T3618] [ 67.482627][ T3618] dump_stack_lvl+0xcd/0x134 [ 67.487343][ T3618] __might_resched.cold+0x222/0x26b [ 67.492633][ T3618] kmem_cache_alloc_trace+0x36f/0x4d0 [ 67.498016][ T3618] kernfs_fop_open+0x2fa/0xfd0 [ 67.502796][ T3618] do_dentry_open+0x4a4/0x13a0 [ 67.507563][ T3618] ? kernfs_fop_read_iter+0x710/0x710 [ 67.512949][ T3618] ? may_open+0x1f6/0x420 [ 67.517282][ T3618] path_openat+0x1c92/0x28f0 [ 67.521889][ T3618] ? path_lookupat+0x840/0x840 [ 67.526656][ T3618] do_filp_open+0x1b6/0x400 [ 67.531165][ T3618] ? may_open_dev+0xf0/0xf0 [ 67.535672][ T3618] ? find_held_lock+0x2d/0x110 [ 67.540450][ T3618] ? do_raw_spin_lock+0x120/0x2a0 [ 67.545479][ T3618] ? rwlock_bug.part.0+0x90/0x90 [ 67.550770][ T3618] ? _find_next_bit+0x1e3/0x260 [ 67.555637][ T3618] ? _raw_spin_unlock+0x24/0x40 [ 67.560490][ T3618] ? alloc_fd+0x2f0/0x6f0 [ 67.564826][ T3618] do_sys_openat2+0x16d/0x4c0 [ 67.569526][ T3618] ? build_open_flags+0x6f0/0x6f0 [ 67.574668][ T3618] ? lock_downgrade+0x6e0/0x6e0 [ 67.579532][ T3618] __x64_sys_openat+0x13f/0x1f0 [ 67.584391][ T3618] ? __ia32_sys_open+0x1c0/0x1c0 [ 67.589343][ T3618] ? syscall_enter_from_user_mode+0x22/0xb0 [ 67.595265][ T3618] ? syscall_enter_from_user_mode+0x22/0xb0 [ 67.601263][ T3618] do_syscall_64+0x35/0xb0 [ 67.605697][ T3618] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 67.611597][ T3618] RIP: 0033:0x7f87fd23c714 [ 67.616111][ T3618] Code: 84 00 00 00 00 00 44 89 54 24 0c e8 96 f9 ff ff 44 8b 54 24 0c 44 89 e2 48 89 ee 41 89 c0 bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 34 44 89 c7 89 44 24 0c e8 c8 f9 ff ff 8b 44 [ 67.635896][ T3618] RSP: 002b:00007ffc532c8820 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 67.644315][ T3618] RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007f87fd23c714 [ 67.652289][ T3618] RDX: 0000000000080001 RSI: 00007ffc532c8e60 RDI: 00000000ffffff9c [ 67.660782][ T3618] RBP: 00007ffc532c8e60 R08: 0000000000000000 R09: 00007ffc532c8810 [ 67.668759][ T3618] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000080001 [ 67.677748][ T3618] R13: 00007ffc532c88c0 R14: 0000000000000000 R15: 00007ffc532c8e60 [ 67.685913][ T3618] [ 67.691911][ T22] Bluetooth: hci0: command 0x0409 tx timeout 2022/09/28 08:44:35 building call list... [ 67.972646][ T11] netdevsim netdevsim0 netdevsim3 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 68.375133][ T3616] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 68.385124][ T3616] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3616, name: kworker/1:3 [ 68.394346][ T3616] preempt_count: 0, expected: 0 [ 68.399207][ T3616] RCU nest depth: 0, expected: 0 [ 68.404156][ T3616] 3 locks held by kworker/1:3/3616: [ 68.409463][ T3616] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 68.419873][ T3616] #1: ffffc90003087da8 ((work_completion)(&data->fib_event_work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 68.431956][ T3616] #2: ffff8880698ac240 (&data->fib_lock){+.+.}-{3:3}, at: nsim_fib_event_work+0x1df/0x2720 [ 68.442213][ T3616] irq event stamp: 5628 [ 68.446388][ T3616] hardirqs last enabled at (5627): [] kfree+0x25b/0x390 [ 68.455047][ T3616] hardirqs last disabled at (5628): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 68.465181][ T3616] softirqs last enabled at (5604): [] __rhashtable_insert_fast.constprop.0+0x9ed/0x1200 [ 68.476693][ T3616] softirqs last disabled at (5602): [] __rhashtable_insert_fast.constprop.0+0x33e/0x1200 [ 68.488124][ T3616] CPU: 1 PID: 3616 Comm: kworker/1:3 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 68.500217][ T3616] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 68.510295][ T3616] Workqueue: events nsim_fib_event_work [ 68.515875][ T3616] Call Trace: [ 68.519170][ T3616] [ 68.522201][ T3616] dump_stack_lvl+0xcd/0x134 [ 68.526997][ T3616] __might_resched.cold+0x222/0x26b [ 68.532305][ T3616] kmem_cache_alloc_trace+0x36f/0x4d0 [ 68.537710][ T3616] nsim_fib_event_work+0x89c/0x2720 [ 68.542932][ T3616] ? nsim_nexthop_event_nb+0x11d0/0x11d0 [ 68.548588][ T3616] ? lock_downgrade+0x6e0/0x6e0 [ 68.553558][ T3616] ? do_raw_spin_lock+0x120/0x2a0 [ 68.558650][ T3616] process_one_work+0x991/0x1610 [ 68.563702][ T3616] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 68.569112][ T3616] ? rwlock_bug.part.0+0x90/0x90 [ 68.574087][ T3616] ? _raw_spin_lock_irq+0x41/0x50 [ 68.579153][ T3616] worker_thread+0x854/0x1080 [ 68.583959][ T3616] ? __kthread_parkme+0x15f/0x220 [ 68.589130][ T3616] ? process_one_work+0x1610/0x1610 [ 68.594367][ T3616] kthread+0x2e4/0x3a0 [ 68.599944][ T3616] ? kthread_complete_and_exit+0x40/0x40 [ 68.605603][ T3616] ret_from_fork+0x1f/0x30 [ 68.610047][ T3616] executing program [ 69.395124][ T3616] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 69.404653][ T3616] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3616, name: kworker/1:3 [ 69.413786][ T3616] preempt_count: 0, expected: 0 [ 69.418681][ T3616] RCU nest depth: 0, expected: 0 [ 69.423635][ T3616] 3 locks held by kworker/1:3/3616: [ 69.428842][ T3616] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 69.439316][ T3616] #1: ffffc90003087da8 ((work_completion)(&data->fib_event_work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 69.451378][ T3616] #2: ffff8880698ac240 (&data->fib_lock){+.+.}-{3:3}, at: nsim_fib_event_work+0x1df/0x2720 [ 69.461528][ T3616] irq event stamp: 6434 [ 69.465960][ T3616] hardirqs last enabled at (6433): [] kfree+0x25b/0x390 [ 69.474604][ T3616] hardirqs last disabled at (6434): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 69.484706][ T3616] softirqs last enabled at (6412): [] __rhashtable_insert_fast.constprop.0+0x9ed/0x1200 [ 69.496193][ T3616] softirqs last disabled at (6410): [] __rhashtable_insert_fast.constprop.0+0x33e/0x1200 [ 69.507599][ T3616] CPU: 1 PID: 3616 Comm: kworker/1:3 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 69.519689][ T3616] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 69.529765][ T3616] Workqueue: events nsim_fib_event_work [ 69.535347][ T3616] Call Trace: [ 69.538640][ T3616] [ 69.541582][ T3616] dump_stack_lvl+0xcd/0x134 [ 69.546193][ T3616] __might_resched.cold+0x222/0x26b [ 69.551510][ T3616] kmem_cache_alloc_trace+0x36f/0x4d0 [ 69.556923][ T3616] nsim_fib_event_work+0x112d/0x2720 [ 69.562678][ T3616] ? nsim_nexthop_event_nb+0x11d0/0x11d0 [ 69.568338][ T3616] ? lock_downgrade+0x6e0/0x6e0 [ 69.573294][ T3616] ? do_raw_spin_lock+0x120/0x2a0 [ 69.578448][ T3616] process_one_work+0x991/0x1610 [ 69.583411][ T3616] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 69.588814][ T3616] ? rwlock_bug.part.0+0x90/0x90 [ 69.593779][ T3616] ? _raw_spin_lock_irq+0x41/0x50 [ 69.598888][ T3616] worker_thread+0x854/0x1080 [ 69.603648][ T3616] ? __kthread_parkme+0x15f/0x220 [ 69.608713][ T3616] ? process_one_work+0x1610/0x1610 [ 69.613981][ T3616] kthread+0x2e4/0x3a0 [ 69.618145][ T3616] ? kthread_complete_and_exit+0x40/0x40 [ 69.623879][ T3616] ret_from_fork+0x1f/0x30 [ 69.628998][ T3616] [ 70.413861][ T3616] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 70.423382][ T3616] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3616, name: kworker/1:3 [ 70.432872][ T3616] preempt_count: 0, expected: 0 [ 70.437733][ T3616] RCU nest depth: 0, expected: 0 [ 70.442691][ T3616] 3 locks held by kworker/1:3/3616: [ 70.448027][ T3616] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 70.458447][ T3616] #1: ffffc90003087da8 ((work_completion)(&data->fib_event_work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 70.470515][ T3616] #2: ffff8880698ac240 (&data->fib_lock){+.+.}-{3:3}, at: nsim_fib_event_work+0x1df/0x2720 [ 70.480768][ T3616] irq event stamp: 7172 [ 70.485032][ T3616] hardirqs last enabled at (7171): [] kfree+0x25b/0x390 [ 70.493653][ T3616] hardirqs last disabled at (7172): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 70.503760][ T3616] softirqs last enabled at (7150): [] __rhashtable_insert_fast.constprop.0+0x9ed/0x1200 [ 70.515207][ T3616] softirqs last disabled at (7148): [] __rhashtable_insert_fast.constprop.0+0x33e/0x1200 [ 70.526717][ T3616] CPU: 1 PID: 3616 Comm: kworker/1:3 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 70.538821][ T3616] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 70.549096][ T3616] Workqueue: events nsim_fib_event_work [ 70.554806][ T3616] Call Trace: [ 70.558119][ T3616] [ 70.561077][ T3616] dump_stack_lvl+0xcd/0x134 [ 70.565817][ T3616] __might_resched.cold+0x222/0x26b [ 70.571106][ T3616] kmem_cache_alloc_trace+0x36f/0x4d0 [ 70.576535][ T3616] nsim_fib_event_work+0x112d/0x2720 [ 70.581880][ T3616] ? nsim_nexthop_event_nb+0x11d0/0x11d0 [ 70.587590][ T3616] ? lock_downgrade+0x6e0/0x6e0 [ 70.592795][ T3616] ? do_raw_spin_lock+0x120/0x2a0 [ 70.597867][ T3616] process_one_work+0x991/0x1610 [ 70.602942][ T3616] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 70.608368][ T3616] ? rwlock_bug.part.0+0x90/0x90 [ 70.613351][ T3616] ? _raw_spin_lock_irq+0x41/0x50 [ 70.618431][ T3616] worker_thread+0x854/0x1080 [ 70.623148][ T3616] ? __kthread_parkme+0x15f/0x220 [ 70.628216][ T3616] ? process_one_work+0x1610/0x1610 [ 70.633485][ T3616] kthread+0x2e4/0x3a0 [ 70.637587][ T3616] ? kthread_complete_and_exit+0x40/0x40 [ 70.643357][ T3616] ret_from_fork+0x1f/0x30 [ 70.647813][ T3616] [ 71.251847][ T11] netdevsim netdevsim0 netdevsim2 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 71.433924][ T3616] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:274 [ 71.443464][ T3616] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 3616, name: kworker/1:3 [ 71.452980][ T3616] preempt_count: 0, expected: 0 [ 71.457970][ T3616] RCU nest depth: 0, expected: 0 [ 71.463007][ T3616] 3 locks held by kworker/1:3/3616: [ 71.468225][ T3616] #0: ffff888011867d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 71.478784][ T3616] #1: ffffc90003087da8 ((work_completion)(&data->fib_event_work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 71.490848][ T3616] #2: ffff8880698ac240 (&data->fib_lock){+.+.}-{3:3}, at: nsim_fib_event_work+0x1df/0x2720 [ 71.501098][ T3616] irq event stamp: 8194 [ 71.505263][ T3616] hardirqs last enabled at (8193): [] kfree+0x25b/0x390 [ 71.513887][ T3616] hardirqs last disabled at (8194): [] kmem_cache_alloc_trace+0x37e/0x4d0 [ 71.523990][ T3616] softirqs last enabled at (8170): [] __rhashtable_insert_fast.constprop.0+0x9ed/0x1200 [ 71.535515][ T3616] softirqs last disabled at (8168): [] __rhashtable_insert_fast.constprop.0+0x33e/0x1200 [ 71.547536][ T3616] CPU: 1 PID: 3616 Comm: kworker/1:3 Tainted: G W 6.0.0-rc6-syzkaller-00321-g105a36f3694e-dirty #0 [ 71.560071][ T3616] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 71.570160][ T3616] Workqueue: events nsim_fib_event_work [ 71.575747][ T3616] Call Trace: [ 71.579050][ T3616] [ 71.581998][ T3616] dump_stack_lvl+0xcd/0x134 [ 71.586626][ T3616] __might_resched.cold+0x222/0x26b [ 71.592043][ T3616] kmem_cache_alloc_trace+0x36f/0x4d0 [ 71.597461][ T3616] nsim_fib_event_work+0x112d/0x2720 [ 71.602792][ T3616] ? nsim_nexthop_event_nb+0x11d0/0x11d0 [ 71.608471][ T3616] ? lock_downgrade+0x6e0/0x6e0 [ 71.613360][ T3616] ? do_raw_spin_lock+0x120/0x2a0 [ 71.619041][ T3616] process_one_work+0x991/0x1610 [ 71.624021][ T3616] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 71.629449][ T3616] ? rwlock_bug.part.0+0x90/0x90 [ 71.634512][ T3616] ? _raw_spin_lock_irq+0x41/0x50 [ 71.639590][ T3616] worker_thread+0x854/0x1080 [ 71.644316][ T3616] ? __kthread_parkme+0x15f/0x220 [ 71.649385][ T3616] ? process_one_work+0x1610/0x1610 [ 71.654818][ T3616] kthread+0x2e4/0x3a0 [ 71.658569][ T27] kauditd_printk_skb: 19 callbacks suppressed [ 71.658586][ T27] audit: type=1400 audit(1664354679.052:105): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="fuse" dev="devtmpfs" ino=98 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fuse_device_t tclass=chr_file permissive=1 [ 71.658998][ T3616] ? kthread_complete_and_exit+0x40/0x40 [ 71.669853][ T27] audit: type=1400 audit(1664354679.052:106): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/fuse" dev="devtmpfs" ino=98 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fuse_device_t tclass=chr_file permissive=1 [ 71.687854][ T3616] ret_from_fork+0x1f/0x30 [ 71.687894][ T3616] [ 71.783970][ T27] audit: type=1400 audit(1664354679.172:107): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="autofs" dev="devtmpfs" ino=97 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:autofs_device_t tclass=chr_file permissive=1 [ 71.834122][ T27] audit: type=1400 audit(1664354679.172:108): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/autofs" dev="devtmpfs" ino=97 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:autofs_device_t tclass=chr_file permissive=1 [ 71.860511][ T27] audit: type=1400 audit(1664354679.172:109): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="btrfs-control" dev="devtmpfs" ino=1116 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:lvm_control_t tclass=chr_file permissive=1 [ 71.885804][ T27] audit: type=1400 audit(1664354679.172:110): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/btrfs-control" dev="devtmpfs" ino=1116 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:lvm_control_t tclass=chr_file permissive=1 [ 71.920503][ T27] audit: type=1400 audit(1664354679.172:111): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="cachefiles" dev="devtmpfs" ino=4 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cachefiles_device_t tclass=chr_file permissive=1 [ 71.973286][ T27] audit: type=1400 audit(1664354679.172:112): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/cachefiles" dev="devtmpfs" ino=4 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cachefiles_device_t tclass=chr_file permissive=1 [ 71.998727][ T27] audit: type=1400 audit(1664354679.182:113): avc: denied { read } for pid=3606 comm="syz-fuzzer" name="renderD128" dev="devtmpfs" ino=623 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:dri_device_t tclass=chr_file permissive=1 [ 72.043451][ T27] audit: type=1400 audit(1664354679.182:114): avc: denied { open } for pid=3606 comm="syz-fuzzer" path="/dev/dri/renderD128" dev="devtmpfs" ino=623 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:dri_device_t tclass=chr_file permissive=1 [ 72.079465][ T3608] can: request_module (can-proto-0) failed. [ 72.116644][ T3608] can: request_module (can-proto-0) failed. [ 72.149068][ T3608] can: request_module (can-proto-0) failed. executing program syzkaller build log: go env (err=) GO111MODULE="auto" GOARCH="amd64" GOBIN="" GOCACHE="/syzkaller/.cache/go-build" GOENV="/syzkaller/.config/go/env" GOEXE="" GOEXPERIMENT="" GOFLAGS="" GOHOSTARCH="amd64" GOHOSTOS="linux" GOINSECURE="" GOMODCACHE="/syzkaller/jobs/linux/gopath/pkg/mod" GONOPROXY="" GONOSUMDB="" GOOS="linux" GOPATH="/syzkaller/jobs/linux/gopath" GOPRIVATE="" GOPROXY="https://proxy.golang.org,direct" GOROOT="/usr/local/go" GOSUMDB="sum.golang.org" GOTMPDIR="" GOTOOLDIR="/usr/local/go/pkg/tool/linux_amd64" GOVCS="" GOVERSION="go1.17" GCCGO="gccgo" AR="ar" CC="gcc" CXX="g++" CGO_ENABLED="1" GOMOD="/syzkaller/jobs/linux/gopath/src/github.com/google/syzkaller/go.mod" CGO_CFLAGS="-g -O2" CGO_CPPFLAGS="" CGO_CXXFLAGS="-g -O2" CGO_FFLAGS="-g -O2" CGO_LDFLAGS="-g -O2" PKG_CONFIG="pkg-config" GOGCCFLAGS="-fPIC -m64 -pthread -fmessage-length=0 -fdebug-prefix-map=/tmp/go-build3708998014=/tmp/go-build -gno-record-gcc-switches" git status (err=) HEAD detached at 0042f2b4c nothing to commit, working tree clean go list -f '{{.Stale}}' ./sys/syz-sysgen | grep -q false || go install ./sys/syz-sysgen make .descriptions bin/syz-sysgen touch .descriptions GOOS=linux GOARCH=amd64 go build "-ldflags=-s -w -X github.com/google/syzkaller/prog.GitRevision=0042f2b4c00ce1ceeaa44a0147909fe3a6f86c5c -X 'github.com/google/syzkaller/prog.gitRevisionDate=20220922-164204'" "-tags=syz_target syz_os_linux syz_arch_amd64 " -o ./bin/linux_amd64/syz-fuzzer github.com/google/syzkaller/syz-fuzzer GOOS=linux GOARCH=amd64 go build "-ldflags=-s -w -X github.com/google/syzkaller/prog.GitRevision=0042f2b4c00ce1ceeaa44a0147909fe3a6f86c5c -X 'github.com/google/syzkaller/prog.gitRevisionDate=20220922-164204'" "-tags=syz_target syz_os_linux syz_arch_amd64 " -o ./bin/linux_amd64/syz-execprog github.com/google/syzkaller/tools/syz-execprog GOOS=linux GOARCH=amd64 go build "-ldflags=-s -w -X github.com/google/syzkaller/prog.GitRevision=0042f2b4c00ce1ceeaa44a0147909fe3a6f86c5c -X 'github.com/google/syzkaller/prog.gitRevisionDate=20220922-164204'" "-tags=syz_target syz_os_linux syz_arch_amd64 " -o ./bin/linux_amd64/syz-stress github.com/google/syzkaller/tools/syz-stress mkdir -p ./bin/linux_amd64 gcc -o ./bin/linux_amd64/syz-executor executor/executor.cc \ -m64 -O2 -pthread -Wall -Werror -Wparentheses -Wunused-const-variable -Wframe-larger-than=16384 -Wno-stringop-overflow -Wno-array-bounds -Wno-format-overflow -static-pie -fpermissive -w -DGOOS_linux=1 -DGOARCH_amd64=1 \ -DHOSTGOOS_linux=1 -DGIT_REVISION=\"0042f2b4c00ce1ceeaa44a0147909fe3a6f86c5c\"