[ 32.591236] audit: type=1800 audit(1550507091.903:27): pid=7259 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="restorecond" dev="sda1" ino=2436 res=0 [ 32.612371] audit: type=1800 audit(1550507091.903:28): pid=7259 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="ssh" dev="sda1" ino=2417 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. [ 33.417027] audit: type=1800 audit(1550507092.763:29): pid=7259 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 [ 33.437262] audit: type=1800 audit(1550507092.773:30): pid=7259 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.0.169' (ECDSA) to the list of known hosts. 2019/02/18 16:25:04 parsed 1 programs 2019/02/18 16:25:06 executed programs: 0 syzkaller login: [ 46.961992] IPVS: ftp: loaded support on port[0] = 21 [ 47.013164] chnl_net:caif_netlink_parms(): no params data found [ 47.041601] bridge0: port 1(bridge_slave_0) entered blocking state [ 47.048368] bridge0: port 1(bridge_slave_0) entered disabled state [ 47.055313] device bridge_slave_0 entered promiscuous mode [ 47.062346] bridge0: port 2(bridge_slave_1) entered blocking state [ 47.068780] bridge0: port 2(bridge_slave_1) entered disabled state [ 47.075594] device bridge_slave_1 entered promiscuous mode [ 47.090369] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 47.099068] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 47.115952] team0: Port device team_slave_0 added [ 47.122150] team0: Port device team_slave_1 added [ 47.169233] device hsr_slave_0 entered promiscuous mode [ 47.237432] device hsr_slave_1 entered promiscuous mode [ 47.303875] bridge0: port 2(bridge_slave_1) entered blocking state [ 47.310319] bridge0: port 2(bridge_slave_1) entered forwarding state [ 47.317095] bridge0: port 1(bridge_slave_0) entered blocking state [ 47.323470] bridge0: port 1(bridge_slave_0) entered forwarding state [ 47.350021] 8021q: adding VLAN 0 to HW filter on device bond0 [ 47.361831] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 47.381159] bridge0: port 1(bridge_slave_0) entered disabled state [ 47.388714] bridge0: port 2(bridge_slave_1) entered disabled state [ 47.395757] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 47.405757] 8021q: adding VLAN 0 to HW filter on device team0 [ 47.413601] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 47.421585] bridge0: port 1(bridge_slave_0) entered blocking state [ 47.427953] bridge0: port 1(bridge_slave_0) entered forwarding state [ 47.444903] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 47.455084] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 47.466169] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 47.474259] bridge0: port 2(bridge_slave_1) entered blocking state [ 47.480715] bridge0: port 2(bridge_slave_1) entered forwarding state [ 47.488470] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 47.496179] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 47.504195] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 47.511802] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 47.519187] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 47.525877] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 47.541341] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 47.855662] [ 47.857336] ===================================== [ 47.862148] WARNING: bad unlock balance detected! [ 47.866975] 5.0.0-rc6+ #76 Not tainted [ 47.870831] ------------------------------------- [ 47.875645] syz-executor.0/7517 is trying to release lock (&file->mut) at: [ 47.882647] [] ucma_destroy_id+0x24c/0x4a0 [ 47.888415] but there are no more locks to release! [ 47.893487] [ 47.893487] other info that might help us debug this: [ 47.900228] 1 lock held by syz-executor.0/7517: [ 47.904865] #0: 000000009959a519 (&file->mut){+.+.}, at: ucma_destroy_id+0x1e9/0x4a0 [ 47.912819] [ 47.912819] stack backtrace: [ 47.917294] CPU: 1 PID: 7517 Comm: syz-executor.0 Not tainted 5.0.0-rc6+ #76 [ 47.924467] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 47.933791] Call Trace: [ 47.936366] dump_stack+0x172/0x1f0 [ 47.939971] ? ucma_destroy_id+0x24c/0x4a0 [ 47.944186] print_unlock_imbalance_bug.cold+0x114/0x123 [ 47.949613] ? ucma_destroy_id+0x24c/0x4a0 [ 47.953826] lock_release+0x67e/0xa00 [ 47.957603] ? lock_downgrade+0x810/0x810 [ 47.961730] ? mutex_trylock+0x1e0/0x1e0 [ 47.965766] __mutex_unlock_slowpath+0x8e/0x6b0 [ 47.970411] ? __sanitizer_cov_trace_const_cmp1+0x1a/0x20 [ 47.975925] ? wait_for_completion+0x440/0x440 [ 47.980481] mutex_unlock+0xd/0x10 [ 47.983996] ucma_destroy_id+0x24c/0x4a0 [ 47.988036] ? ucma_close+0x320/0x320 [ 47.991813] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 47.997338] ? _copy_from_user+0xdd/0x150 [ 48.001464] ucma_write+0x2da/0x3c0 [ 48.005066] ? ucma_close+0x320/0x320 [ 48.008841] ? ucma_open+0x290/0x290 [ 48.012542] ? __fget+0x340/0x540 [ 48.015973] __vfs_write+0x116/0x8e0 [ 48.019683] ? lock_downgrade+0x810/0x810 [ 48.023806] ? ucma_open+0x290/0x290 [ 48.027500] ? kernel_read+0x120/0x120 [ 48.031366] ? debug_lockdep_rcu_enabled+0x71/0xa0 [ 48.036270] ? common_file_perm+0x1d6/0x6f0 [ 48.040568] ? apparmor_file_permission+0x25/0x30 [ 48.045398] ? __sanitizer_cov_trace_const_cmp4+0x16/0x20 [ 48.050910] ? security_file_permission+0x94/0x320 [ 48.055813] ? rw_verify_area+0x118/0x360 [ 48.059941] vfs_write+0x20c/0x580 [ 48.063459] ksys_write+0xea/0x1f0 [ 48.067088] ? __ia32_sys_read+0xb0/0xb0 [ 48.071128] ? do_syscall_64+0x26/0x610 [ 48.075190] ? entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 48.080529] ? do_syscall_64+0x26/0x610 [ 48.084578] __x64_sys_write+0x73/0xb0 [ 48.088445] do_syscall_64+0x103/0x610 [ 48.092308] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 48.097473] RIP: 0033:0x457e29 [ 48.100644] Code: ad b8 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 7b b8 fb ff c3 66 2e 0f 1f 84 00 00 00 00 [ 48.119538] RSP: 002b:00007fa4b4858c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 48.127229] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457e29 [ 48.134572] RDX: 0000000000000018 RSI: 0000000020000180 RDI: 0000000000000005 [ 48.141814] RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 [ 48.149061] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fa4b48596d4 [ 48.156392] R13: 00000000004cd790 R14: 00000000004dc9d0 R15: 00000000ffffffff