[ 81.493460][ T27] audit: type=1800 audit(1581088704.399:26): pid=9786 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2457 res=0 [....] Starting periodic command scheduler: cron[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[ ok 8[?25h[?0c. [ 82.413486][ T27] kauditd_printk_skb: 2 callbacks suppressed [ 82.413497][ T27] audit: type=1800 audit(1581088705.349:29): pid=9786 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="rc.local" dev="sda1" ino=2432 res=0 [ 82.441272][ T27] audit: type=1800 audit(1581088705.359:30): pid=9786 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="rmnologin" dev="sda1" ino=2423 res=0 Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.10.17' (ECDSA) to the list of known hosts. 2020/02/07 15:18:52 parsed 1 programs 2020/02/07 15:18:54 executed programs: 0 syzkaller login: [ 111.629681][ T9957] IPVS: ftp: loaded support on port[0] = 21 [ 111.692294][ T9957] chnl_net:caif_netlink_parms(): no params data found [ 111.729637][ T9957] bridge0: port 1(bridge_slave_0) entered blocking state [ 111.737414][ T9957] bridge0: port 1(bridge_slave_0) entered disabled state [ 111.745347][ T9957] device bridge_slave_0 entered promiscuous mode [ 111.755156][ T9957] bridge0: port 2(bridge_slave_1) entered blocking state [ 111.762422][ T9957] bridge0: port 2(bridge_slave_1) entered disabled state [ 111.770324][ T9957] device bridge_slave_1 entered promiscuous mode [ 111.788243][ T9957] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 111.799176][ T9957] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 111.819360][ T9957] team0: Port device team_slave_0 added [ 111.826857][ T9957] team0: Port device team_slave_1 added [ 111.842589][ T9957] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 111.849714][ T9957] 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. [ 111.875949][ T9957] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 111.889190][ T9957] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 111.896461][ T9957] 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. [ 111.922460][ T9957] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 112.005462][ T9957] device hsr_slave_0 entered promiscuous mode [ 112.053723][ T9957] device hsr_slave_1 entered promiscuous mode [ 112.180494][ T9957] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 112.237184][ T9957] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 112.325613][ T9957] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 112.376157][ T9957] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 112.426032][ T9957] bridge0: port 2(bridge_slave_1) entered blocking state [ 112.433230][ T9957] bridge0: port 2(bridge_slave_1) entered forwarding state [ 112.441354][ T9957] bridge0: port 1(bridge_slave_0) entered blocking state [ 112.448608][ T9957] bridge0: port 1(bridge_slave_0) entered forwarding state [ 112.494804][ T9957] 8021q: adding VLAN 0 to HW filter on device bond0 [ 112.507841][ T2845] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 112.518899][ T2845] bridge0: port 1(bridge_slave_0) entered disabled state [ 112.527232][ T2845] bridge0: port 2(bridge_slave_1) entered disabled state [ 112.536099][ T2845] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 112.549616][ T9957] 8021q: adding VLAN 0 to HW filter on device team0 [ 112.561106][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 112.570189][ T2889] bridge0: port 1(bridge_slave_0) entered blocking state [ 112.577303][ T2889] bridge0: port 1(bridge_slave_0) entered forwarding state [ 112.588981][ T2845] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 112.598444][ T2845] bridge0: port 2(bridge_slave_1) entered blocking state [ 112.605808][ T2845] bridge0: port 2(bridge_slave_1) entered forwarding state [ 112.625473][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 112.634743][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 112.646561][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 112.662678][ T9957] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 112.675055][ T9957] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 112.687929][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 112.696590][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 112.705177][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 112.722624][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 112.731095][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 112.747209][ T9957] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 112.766325][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 112.776019][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 112.796178][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 112.805152][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 112.816307][ T9957] device veth0_vlan entered promiscuous mode [ 112.825961][ T2858] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 112.834529][ T2858] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 112.846840][ T9957] device veth1_vlan entered promiscuous mode [ 112.871248][ T9957] device veth0_macvtap entered promiscuous mode [ 112.879495][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 112.888273][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 112.896440][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 112.905724][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 112.915482][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 112.926864][ T9957] device veth1_macvtap entered promiscuous mode [ 112.945056][ T9957] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 112.952677][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 112.961340][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 112.970985][ T2859] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 112.982734][ T9957] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 112.990437][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 112.999981][ T2889] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 113.234013][ C0] [ 113.236384][ C0] ================================ [ 113.242362][ C0] WARNING: inconsistent lock state [ 113.247493][ C0] 5.5.0-syzkaller #0 Not tainted [ 113.252459][ C0] -------------------------------- [ 113.262507][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 113.269350][ C0] syz-execprog/9944 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 113.275874][ C0] ffff88809abf59c8 (&(&local->client_conns_lock)->rlock){+.?.}, at: rxrpc_put_client_conn+0x6ed/0xc90 [ 113.286863][ C0] {SOFTIRQ-ON-W} state was registered at: [ 113.292698][ C0] lock_acquire+0x190/0x410 [ 113.297282][ C0] _raw_spin_lock+0x2f/0x40 [ 113.301858][ C0] rxrpc_connect_call+0x358/0x4e30 [ 113.307170][ C0] rxrpc_new_client_call+0x9c0/0x1ad0 [ 113.312754][ C0] rxrpc_do_sendmsg+0xffa/0x1d5f [ 113.317776][ C0] rxrpc_sendmsg+0x4d6/0x5f0 [ 113.322449][ C0] sock_sendmsg+0xd7/0x130 [ 113.326950][ C0] ____sys_sendmsg+0x358/0x880 [ 113.331781][ C0] ___sys_sendmsg+0x100/0x170 [ 113.336535][ C0] __sys_sendmmsg+0x1bf/0x4d0 [ 113.341396][ C0] __x64_sys_sendmmsg+0x9d/0x100 [ 113.346439][ C0] do_syscall_64+0xfa/0x790 [ 113.351046][ C0] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 113.357008][ C0] irq event stamp: 26350 [ 113.361239][ C0] hardirqs last enabled at (26350): [] _raw_spin_unlock_irqrestore+0x66/0xe0 [ 113.371756][ C0] hardirqs last disabled at (26349): [] _raw_spin_lock_irqsave+0x6f/0xcd [ 113.381871][ C0] softirqs last enabled at (22878): [] __do_softirq+0x6cd/0x98c [ 113.391270][ C0] softirqs last disabled at (26193): [] irq_exit+0x19b/0x1e0 [ 113.400181][ C0] [ 113.400181][ C0] other info that might help us debug this: [ 113.408349][ C0] Possible unsafe locking scenario: [ 113.408349][ C0] [ 113.415781][ C0] CPU0 [ 113.419056][ C0] ---- [ 113.422355][ C0] lock(&(&local->client_conns_lock)->rlock); [ 113.428507][ C0] [ 113.431942][ C0] lock(&(&local->client_conns_lock)->rlock); [ 113.438253][ C0] [ 113.438253][ C0] *** DEADLOCK *** [ 113.438253][ C0] [ 113.446385][ C0] 2 locks held by syz-execprog/9944: [ 113.451656][ C0] #0: ffff888099b82428 (sb_writers#3){.+.+}, at: mnt_want_write+0x3f/0xc0 [ 113.460255][ C0] #1: ffffffff89bac140 (rcu_callback){....}, at: rcu_core+0x562/0x1390 [ 113.468577][ C0] [ 113.468577][ C0] stack backtrace: [ 113.474466][ C0] CPU: 0 PID: 9944 Comm: syz-execprog Not tainted 5.5.0-syzkaller #0 [ 113.482511][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 113.492558][ C0] Call Trace: [ 113.495823][ C0] [ 113.498660][ C0] dump_stack+0x197/0x210 [ 113.502969][ C0] print_usage_bug.cold+0x327/0x378 [ 113.508147][ C0] mark_lock+0xbb4/0x1220 [ 113.512486][ C0] ? rcu_core_si+0x9/0x10 [ 113.516801][ C0] ? check_usage_backwards+0x330/0x330 [ 113.522238][ C0] ? irq_exit+0x19b/0x1e0 [ 113.526561][ C0] __lock_acquire+0x1e8e/0x4a00 [ 113.531528][ C0] ? __kasan_check_read+0x11/0x20 [ 113.536539][ C0] ? mark_lock+0xc2/0x1220 [ 113.540953][ C0] ? mark_held_locks+0xf0/0xf0 [ 113.545700][ C0] ? _raw_spin_unlock_irqrestore+0x66/0xe0 [ 113.551673][ C0] lock_acquire+0x190/0x410 [ 113.556174][ C0] ? rxrpc_put_client_conn+0x6ed/0xc90 [ 113.561633][ C0] _raw_spin_lock+0x2f/0x40 [ 113.566129][ C0] ? rxrpc_put_client_conn+0x6ed/0xc90 [ 113.571590][ C0] rxrpc_put_client_conn+0x6ed/0xc90 [ 113.576878][ C0] ? rxrpc_rcu_destroy_call+0xbd/0x200 [ 113.582607][ C0] rxrpc_rcu_destroy_call+0xbd/0x200 [ 113.587890][ C0] rcu_core+0x5e1/0x1390 [ 113.592259][ C0] ? __rcu_read_unlock+0x700/0x700 [ 113.597358][ C0] ? rcu_read_lock_sched_held+0x9c/0xd0 [ 113.602900][ C0] ? rcu_read_lock_any_held.part.0+0x50/0x50 [ 113.608934][ C0] rcu_core_si+0x9/0x10 [ 113.613076][ C0] __do_softirq+0x262/0x98c [ 113.617619][ C0] ? sched_clock_cpu+0x1b/0x1b0 [ 113.622474][ C0] irq_exit+0x19b/0x1e0 [ 113.626666][ C0] smp_apic_timer_interrupt+0x1a3/0x610 [ 113.632213][ C0] apic_timer_interrupt+0xf/0x20 [ 113.637130][ C0] [ 113.640063][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x90/0xe0 [ 113.646538][ C0] Code: 48 c7 c0 78 b0 b3 89 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 75 39 48 83 3d 2f ef c6 01 00 74 24 48 89 df 57 9d <0f> 1f 44 00 00 bf 01 00 00 00 e8 31 03 64 f9 65 8b 05 22 5d 15 78 [ 113.666145][ C0] RSP: 0018:ffffc900062f7718 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff13 [ 113.674667][ C0] RAX: 1ffffffff136760f RBX: 0000000000000282 RCX: 0000000000000007 [ 113.682679][ C0] RDX: dffffc0000000000 RSI: 0000000000000008 RDI: 0000000000000282 [ 113.690649][ C0] RBP: ffffc900062f7728 R08: 1ffffffff16a217d R09: fffffbfff16a217e [ 113.698669][ C0] R10: fffffbfff16a217d R11: ffffffff8b510bef R12: ffffffff8bafccc8 [ 113.706633][ C0] R13: ffffffff8bafccc8 R14: ffff888087552000 R15: 0000000000000003 [ 113.714619][ C0] debug_check_no_obj_freed+0x20a/0x441 [ 113.720148][ C0] ? rcu_read_lock_sched_held+0x9c/0xd0 [ 113.725674][ C0] ? __sanitizer_cov_trace_const_cmp1+0x1a/0x20 [ 113.731939][ C0] free_pcp_prepare+0x208/0x4f0 [ 113.736813][ C0] free_unref_page_list+0xe1/0x800 [ 113.741909][ C0] ? trace_hardirqs_on+0x67/0x240 [ 113.746930][ C0] release_pages+0x6bf/0x1ac0 [ 113.751607][ C0] ? __activate_page+0x1460/0x1460 [ 113.756789][ C0] ? shadow_lru_isolate+0x430/0x430 [ 113.761980][ C0] __pagevec_release+0x88/0x120 [ 113.766838][ C0] truncate_inode_pages_range+0xa84/0x1980 [ 113.772766][ C0] ? generic_error_remove_page+0xc0/0xc0 [ 113.778511][ C0] ? __kasan_check_read+0x11/0x20 [ 113.783522][ C0] ? mark_lock+0xc2/0x1220 [ 113.787921][ C0] ? ksm_scan_thread+0x1bef/0x5140 [ 113.793074][ C0] ? trace_hardirqs_on+0x67/0x240 [ 113.798152][ C0] truncate_inode_pages_final+0xa0/0xe0 [ 113.803696][ C0] ext4_evict_inode+0x510/0x1590 [ 113.808692][ C0] ? ext4_da_write_begin+0xc70/0xc70 [ 113.814024][ C0] ? do_raw_spin_unlock+0x181/0x270 [ 113.819266][ C0] ? ext4_da_write_begin+0xc70/0xc70 [ 113.824552][ C0] evict+0x306/0x680 [ 113.828446][ C0] ? do_raw_spin_unlock+0x181/0x270 [ 113.833683][ C0] iput+0x55d/0x900 [ 113.837479][ C0] do_unlinkat+0x44c/0x6d0 [ 113.841906][ C0] ? __ia32_sys_rmdir+0x40/0x40 [ 113.846757][ C0] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 113.853311][ C0] ? __sanitizer_cov_trace_const_cmp4+0x16/0x20 [ 113.859800][ C0] ? getname_flags+0x277/0x5b0 [ 113.864551][ C0] __x64_sys_unlinkat+0xc6/0x120 [ 113.869468][ C0] do_syscall_64+0xfa/0x790 [ 113.873991][ C0] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 113.879944][ C0] RIP: 0033:0x4a9200 [ 113.883828][ C0] Code: 8b 7c 24 10 48 8b 74 24 18 48 8b 54 24 20 49 c7 c2 00 00 00 00 49 c7 c0 00 00 00 00 49 c7 c1 00 00 00 00 48 8b 44 24 08 0f 05 <48> 3d 01 f0 ff ff 76 20 48 c7 44 24 28 ff ff ff ff 48 c7 44 24 30 [ 113.903439][ C0] RSP: 002b:000000c0000b5d70 EFLAGS: 00000202 ORIG_RAX: 0000000000000107 [ 113.911952][ C0] RAX: ffffffffffffffda RBX: 000000c000020500 RCX: 00000000004a9200 [ 113.920031][ C0] RDX: 0000000000000000 RSI: 000000c000082860 RDI: ffffffffffffff9c [ 113.928006][ C0] RBP: 000000c0000b5dc8 R08: 0000000000000000 R09: 0000000000000000 [ 113.935976][ C0] R10: 0000000000000000 R11: 0000000000000202 R12: ffffffffffffffff [ 113.943939][ C0] R13: 0000000000000044 R14: 0000000000000043 R15: 0000000000000100