[info] Using makefile-style concurrent boot in runlevel 2. [ 24.473955] audit: type=1800 audit(1540725580.622:21): pid=5432 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="bootlogs" dev="sda1" ino=2419 res=0 [ 24.502732] audit: type=1800 audit(1540725580.632:22): pid=5432 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="motd" dev="sda1" ino=2447 res=0 [....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting periodic command scheduler: cron[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[ ok 8[?25h[?0c. Debian GNU/Linux 7 syzkaller ttyS0 syzkaller login: [ 41.985703] sshd (5573) used greatest stack depth: 15744 bytes left Warning: Permanently added '10.128.0.117' (ECDSA) to the list of known hosts. 2018/10/28 11:20:04 fuzzer started 2018/10/28 11:20:07 dialing manager at 10.128.0.26:37113 [ 50.870125] ld (5595) used greatest stack depth: 15296 bytes left 2018/10/28 11:20:07 syscalls: 1 2018/10/28 11:20:07 code coverage: enabled 2018/10/28 11:20:07 comparison tracing: enabled 2018/10/28 11:20:07 setuid sandbox: enabled 2018/10/28 11:20:07 namespace sandbox: enabled 2018/10/28 11:20:07 Android sandbox: /sys/fs/selinux/policy does not exist 2018/10/28 11:20:07 fault injection: enabled 2018/10/28 11:20:07 leak checking: CONFIG_DEBUG_KMEMLEAK is not enabled 2018/10/28 11:20:07 net packed injection: enabled 2018/10/28 11:20:07 net device setup: enabled 11:23:19 executing program 0: [ 243.855919] IPVS: ftp: loaded support on port[0] = 21 11:23:20 executing program 1: [ 244.527801] IPVS: ftp: loaded support on port[0] = 21 11:23:20 executing program 2: [ 244.846009] IPVS: ftp: loaded support on port[0] = 21 11:23:21 executing program 3: [ 245.269966] IPVS: ftp: loaded support on port[0] = 21 [ 245.369069] bridge0: port 1(bridge_slave_0) entered blocking state [ 245.382240] bridge0: port 1(bridge_slave_0) entered disabled state [ 245.390304] device bridge_slave_0 entered promiscuous mode 11:23:21 executing program 4: [ 245.534439] bridge0: port 2(bridge_slave_1) entered blocking state [ 245.563180] bridge0: port 2(bridge_slave_1) entered disabled state [ 245.576532] device bridge_slave_1 entered promiscuous mode [ 245.695335] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 245.786367] IPVS: ftp: loaded support on port[0] = 21 [ 245.817994] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready 11:23:22 executing program 5: [ 246.236301] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 246.375151] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 246.474678] IPVS: ftp: loaded support on port[0] = 21 [ 246.538888] bridge0: port 1(bridge_slave_0) entered blocking state [ 246.545697] bridge0: port 1(bridge_slave_0) entered disabled state [ 246.553008] device bridge_slave_0 entered promiscuous mode [ 246.673014] bridge0: port 2(bridge_slave_1) entered blocking state [ 246.699437] bridge0: port 2(bridge_slave_1) entered disabled state [ 246.716479] device bridge_slave_1 entered promiscuous mode [ 246.830398] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 246.937007] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready [ 247.015135] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 247.023020] team0: Port device team_slave_0 added [ 247.099170] bridge0: port 1(bridge_slave_0) entered blocking state [ 247.113021] bridge0: port 1(bridge_slave_0) entered disabled state [ 247.135947] device bridge_slave_0 entered promiscuous mode [ 247.147113] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 247.166391] team0: Port device team_slave_1 added [ 247.265340] IPv6: ADDRCONF(NETDEV_UP): veth0_to_team: link is not ready [ 247.272279] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 247.286817] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 247.302063] bridge0: port 2(bridge_slave_1) entered blocking state [ 247.309825] bridge0: port 2(bridge_slave_1) entered disabled state [ 247.317687] device bridge_slave_1 entered promiscuous mode [ 247.340743] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 247.430560] IPv6: ADDRCONF(NETDEV_UP): veth1_to_team: link is not ready [ 247.443655] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 247.452602] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 247.463119] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 247.536873] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 247.546886] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready [ 247.555063] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 247.575359] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 247.583339] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 247.630702] bridge0: port 1(bridge_slave_0) entered blocking state [ 247.644706] bridge0: port 1(bridge_slave_0) entered disabled state [ 247.655478] device bridge_slave_0 entered promiscuous mode [ 247.717459] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 247.745851] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 247.765868] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 247.879200] bridge0: port 2(bridge_slave_1) entered blocking state [ 247.915207] bridge0: port 2(bridge_slave_1) entered disabled state [ 247.925298] device bridge_slave_1 entered promiscuous mode [ 247.985277] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 248.077986] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 248.145738] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 248.164675] bridge0: port 1(bridge_slave_0) entered blocking state [ 248.185891] bridge0: port 1(bridge_slave_0) entered disabled state [ 248.214078] device bridge_slave_0 entered promiscuous mode [ 248.247914] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready [ 248.266186] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 248.273588] team0: Port device team_slave_0 added [ 248.295220] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bond: link is not ready [ 248.305233] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 248.344424] bridge0: port 2(bridge_slave_1) entered blocking state [ 248.375990] bridge0: port 2(bridge_slave_1) entered disabled state [ 248.383346] device bridge_slave_1 entered promiscuous mode [ 248.408305] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bond: link is not ready [ 248.430566] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 248.444029] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 248.477985] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 248.503490] team0: Port device team_slave_1 added [ 248.538815] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready [ 248.666105] IPv6: ADDRCONF(NETDEV_UP): veth0_to_team: link is not ready [ 248.674299] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 248.690951] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 248.715698] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 248.776651] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 248.856537] bridge0: port 1(bridge_slave_0) entered blocking state [ 248.863019] bridge0: port 1(bridge_slave_0) entered disabled state [ 248.875954] device bridge_slave_0 entered promiscuous mode [ 248.888006] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 248.901221] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 248.916531] team0: Port device team_slave_0 added [ 248.935507] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 248.976630] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 248.993080] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 249.006687] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 249.017794] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 249.040515] team0: Port device team_slave_1 added [ 249.051253] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bond: link is not ready [ 249.065204] bridge0: port 2(bridge_slave_1) entered blocking state [ 249.071592] bridge0: port 2(bridge_slave_1) entered disabled state [ 249.096902] device bridge_slave_1 entered promiscuous mode [ 249.103185] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 249.116346] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 249.130733] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 249.139490] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 249.179866] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 249.202520] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bond: link is not ready [ 249.210058] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 249.222794] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready [ 249.248432] bridge0: port 2(bridge_slave_1) entered blocking state [ 249.254956] bridge0: port 2(bridge_slave_1) entered forwarding state [ 249.261902] bridge0: port 1(bridge_slave_0) entered blocking state [ 249.268351] bridge0: port 1(bridge_slave_0) entered forwarding state [ 249.282958] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 249.296287] IPv6: ADDRCONF(NETDEV_UP): veth0_to_team: link is not ready [ 249.303305] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bond: link is not ready [ 249.339816] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 249.353210] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 249.385420] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 249.396863] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready [ 249.433721] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bond: link is not ready [ 249.449777] IPv6: ADDRCONF(NETDEV_UP): veth1_to_team: link is not ready [ 249.465941] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 249.483150] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 249.530840] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 249.606825] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 249.614946] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 249.635943] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 249.718015] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 249.735569] team0: Port device team_slave_0 added [ 249.785210] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 249.792790] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 249.801810] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 249.869595] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 249.878754] team0: Port device team_slave_1 added [ 249.890158] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 249.904184] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 249.932502] team0: Port device team_slave_0 added [ 249.996318] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 250.004013] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 250.034370] IPv6: ADDRCONF(NETDEV_UP): veth0_to_team: link is not ready [ 250.055036] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 250.064747] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 250.099243] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 250.115855] team0: Port device team_slave_1 added [ 250.147710] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bond: link is not ready [ 250.165441] IPv6: ADDRCONF(NETDEV_UP): veth1_to_team: link is not ready [ 250.172334] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 250.195593] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 250.203482] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 250.256600] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bond: link is not ready [ 250.265888] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 250.279542] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 250.305564] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 250.335625] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 250.354108] IPv6: ADDRCONF(NETDEV_UP): veth0_to_team: link is not ready [ 250.378289] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 250.388576] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 250.409172] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 250.429406] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 250.448622] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 250.469591] IPv6: ADDRCONF(NETDEV_UP): veth1_to_team: link is not ready [ 250.494575] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 250.515619] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 250.592607] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 250.605689] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 250.622873] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 250.675926] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 250.695469] team0: Port device team_slave_0 added [ 250.703321] bridge0: port 2(bridge_slave_1) entered blocking state [ 250.709778] bridge0: port 2(bridge_slave_1) entered forwarding state [ 250.716690] bridge0: port 1(bridge_slave_0) entered blocking state [ 250.723081] bridge0: port 1(bridge_slave_0) entered forwarding state [ 250.731639] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 250.766690] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 250.774468] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 250.795688] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 250.846784] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 250.854726] team0: Port device team_slave_1 added [ 250.996265] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 251.005750] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 251.078324] IPv6: ADDRCONF(NETDEV_UP): veth1_to_team: link is not ready [ 251.092886] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 251.105009] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 251.195190] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 251.202353] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 251.218995] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 251.345181] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 251.352328] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 251.363329] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 251.498304] bridge0: port 2(bridge_slave_1) entered blocking state [ 251.504689] bridge0: port 2(bridge_slave_1) entered forwarding state [ 251.511417] bridge0: port 1(bridge_slave_0) entered blocking state [ 251.517817] bridge0: port 1(bridge_slave_0) entered forwarding state [ 251.546849] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 251.937317] bridge0: port 2(bridge_slave_1) entered blocking state [ 251.943726] bridge0: port 2(bridge_slave_1) entered forwarding state [ 251.950467] bridge0: port 1(bridge_slave_0) entered blocking state [ 251.956872] bridge0: port 1(bridge_slave_0) entered forwarding state [ 251.971224] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 252.004922] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 252.012204] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 252.063089] bridge0: port 2(bridge_slave_1) entered blocking state [ 252.069558] bridge0: port 2(bridge_slave_1) entered forwarding state [ 252.076276] bridge0: port 1(bridge_slave_0) entered blocking state [ 252.082662] bridge0: port 1(bridge_slave_0) entered forwarding state [ 252.111361] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 252.878427] bridge0: port 2(bridge_slave_1) entered blocking state [ 252.884861] bridge0: port 2(bridge_slave_1) entered forwarding state [ 252.891546] bridge0: port 1(bridge_slave_0) entered blocking state [ 252.898005] bridge0: port 1(bridge_slave_0) entered forwarding state [ 252.911302] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready [ 253.085120] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 253.095687] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 254.965509] 8021q: adding VLAN 0 to HW filter on device bond0 [ 255.432763] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 255.876431] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 255.882588] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 255.895502] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 255.996320] 8021q: adding VLAN 0 to HW filter on device bond0 [ 256.328434] 8021q: adding VLAN 0 to HW filter on device team0 [ 256.405914] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 256.740433] 8021q: adding VLAN 0 to HW filter on device bond0 [ 256.858218] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 256.865587] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 256.872686] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 257.125889] 8021q: adding VLAN 0 to HW filter on device bond0 [ 257.258546] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 257.284302] 8021q: adding VLAN 0 to HW filter on device bond0 [ 257.294067] 8021q: adding VLAN 0 to HW filter on device team0 [ 257.652843] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 257.707889] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 257.714061] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 257.735554] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 257.818324] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 257.966573] 8021q: adding VLAN 0 to HW filter on device bond0 [ 258.145412] 8021q: adding VLAN 0 to HW filter on device team0 [ 258.166284] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 258.172440] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 258.181566] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 258.341081] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 258.352340] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 258.361924] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 258.457005] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 258.648335] 8021q: adding VLAN 0 to HW filter on device team0 [ 258.769605] 8021q: adding VLAN 0 to HW filter on device team0 [ 258.889052] IPv6: ADDRCONF(NETDEV_UP): veth1: link is not ready [ 258.909056] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 258.919728] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready 11:23:35 executing program 0: socketpair$unix(0x1, 0x0, 0x0, &(0x7f0000000080)) perf_event_open(&(0x7f0000000180)={0x1, 0x70, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1ff, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_config_ext}, 0x0, 0xffffffffffffffff, 0xffffffffffffffff, 0x0) r0 = bpf$PROG_LOAD(0x5, &(0x7f0000000000)={0x1, 0x8, &(0x7f0000000240)=ANY=[@ANYBLOB="7a0af8ff75256400bfa100000000000007010000f8ffffffb702000004000000bf130000000000008500000006000000b7000000000000009500000000000000"], &(0x7f0000000100)='GPL\x00'}, 0x48) bpf$BPF_PROG_TEST_RUN(0xa, &(0x7f0000000080)={r0, 0x8000a0, 0xe, 0x85, &(0x7f0000000300)="00000074000000000000000039e4", &(0x7f0000000340)=""/133, 0x429}, 0x28) setsockopt$sock_attach_bpf(0xffffffffffffffff, 0x29, 0x24, &(0x7f0000000000), 0x4) ioctl$UI_SET_MSCBIT(0xffffffffffffffff, 0x40045568, 0x3b) [ 259.296022] hrtimer: interrupt took 31232 ns [ 259.303075] [ 259.314107] ********************************************************** [ 259.352275] 8021q: adding VLAN 0 to HW filter on device team0 [ 259.375816] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 259.414495] ** ** [ 259.446295] ** trace_printk() being used. Allocating extra memory. ** [ 259.469623] ** ** [ 259.505289] ** This means that this is a DEBUG kernel and it is ** [ 259.544842] ** unsafe for production use. ** [ 259.551573] ** ** [ 259.575097] ** If you see this message and you are not debugging ** [ 259.603143] ** the kernel, report this immediately to your vendor! ** [ 259.635163] ** ** [ 259.642075] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 259.661046] ********************************************************** [ 259.732101] ODEBUG: object 0000000058724606 is on stack 000000007f36ece7, but NOT annotated. [ 259.744480] WARNING: CPU: 0 PID: 6962 at lib/debugobjects.c:369 __debug_object_init.cold.14+0x51/0xdf [ 259.753848] Kernel panic - not syncing: panic_on_warn set ... [ 259.759745] CPU: 0 PID: 6962 Comm: syz-executor0 Not tainted 4.19.0-rc8-next-20181019+ #98 [ 259.768150] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 259.777501] Call Trace: [ 259.780098] dump_stack+0x244/0x39d [ 259.783737] ? dump_stack_print_info.cold.1+0x20/0x20 [ 259.788940] panic+0x2ad/0x55c [ 259.792140] ? add_taint.cold.5+0x16/0x16 [ 259.796298] ? __warn.cold.8+0x5/0x45 [ 259.800107] ? __debug_object_init.cold.14+0x51/0xdf [ 259.805219] __warn.cold.8+0x20/0x45 [ 259.808946] ? __debug_object_init.cold.14+0x51/0xdf [ 259.814059] report_bug+0x254/0x2d0 [ 259.817757] do_error_trap+0x11b/0x200 [ 259.821658] do_invalid_op+0x36/0x40 [ 259.825376] ? __debug_object_init.cold.14+0x51/0xdf [ 259.830542] invalid_op+0x14/0x20 [ 259.834009] RIP: 0010:__debug_object_init.cold.14+0x51/0xdf [ 259.839722] Code: ea 03 80 3c 02 00 75 7c 49 8b 54 24 18 48 89 de 48 c7 c7 c0 f1 40 88 4c 89 85 d0 fd ff ff e8 09 8c d1 fd 4c 8b 85 d0 fd ff ff <0f> 0b e9 09 d6 ff ff 41 83 c4 01 b8 ff ff 37 00 44 89 25 b7 4e 66 [ 259.858626] RSP: 0018:ffff8801892e7308 EFLAGS: 00010086 [ 259.863991] RAX: 0000000000000050 RBX: ffff8801892e7af8 RCX: ffffc90001e6a000 [ 259.871267] RDX: 0000000000000000 RSI: ffffffff816585a5 RDI: 0000000000000005 [ 259.878542] RBP: ffff8801892e7560 R08: ffff8801c95f5668 R09: ffffed003b5c5008 [ 259.885815] R10: ffffed003b5c5008 R11: ffff8801dae28047 R12: ffff8801c14a6080 [ 259.893092] R13: 00000000000a8800 R14: ffff8801c14a6080 R15: ffff8801c95f5658 [ 259.900379] ? vprintk_func+0x85/0x181 [ 259.904292] ? __debug_object_init.cold.14+0x4a/0xdf [ 259.909423] ? lockdep_hardirqs_on+0x3bb/0x5b0 [ 259.914025] ? debug_object_free+0x690/0x690 [ 259.918457] ? unwind_get_return_address+0x61/0xa0 [ 259.923425] ? _raw_spin_unlock_irqrestore+0x6d/0xd0 [ 259.928544] ? depot_save_stack+0x292/0x470 [ 259.932881] ? save_stack+0xa9/0xd0 [ 259.936517] ? save_stack+0x43/0xd0 [ 259.940152] ? kasan_kmalloc+0xc7/0xe0 [ 259.944051] ? bpf_test_init.isra.10+0x98/0x100 [ 259.948727] ? zap_class+0x640/0x640 [ 259.952456] ? do_syscall_64+0x1b9/0x820 [ 259.956531] ? entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 259.961909] ? find_held_lock+0x36/0x1c0 [ 259.965979] debug_object_init+0x16/0x20 [ 259.970041] init_timer_key+0xa9/0x480 [ 259.973932] ? init_timer_on_stack_key+0xe0/0xe0 [ 259.978688] ? __might_fault+0x12b/0x1e0 [ 259.982748] ? __lockdep_init_map+0x105/0x590 [ 259.987256] ? __lockdep_init_map+0x105/0x590 [ 259.991755] ? lockdep_init_map+0x9/0x10 [ 259.995823] sock_init_data+0xe1/0xdc0 [ 259.999708] ? sk_stop_timer+0x50/0x50 [ 260.003619] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 260.009157] ? _copy_from_user+0xdf/0x150 [ 260.013309] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 260.018846] ? bpf_test_init.isra.10+0x70/0x100 [ 260.023521] bpf_prog_test_run_skb+0x255/0xc40 [ 260.028110] ? __lock_acquire+0x62f/0x4c20 [ 260.032348] ? bpf_test_finish.isra.9+0x1f0/0x1f0 [ 260.037194] ? __lock_acquire+0x62f/0x4c20 [ 260.041514] ? fput+0x130/0x1a0 [ 260.044794] ? __bpf_prog_get+0x9b/0x290 [ 260.048855] ? bpf_test_finish.isra.9+0x1f0/0x1f0 [ 260.053695] bpf_prog_test_run+0x130/0x1a0 [ 260.057929] __x64_sys_bpf+0x3d8/0x510 [ 260.061815] ? bpf_prog_get+0x20/0x20 [ 260.065630] do_syscall_64+0x1b9/0x820 [ 260.069519] ? entry_SYSCALL_64_after_hwframe+0x3e/0xbe [ 260.074881] ? syscall_return_slowpath+0x5e0/0x5e0 [ 260.079809] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 260.084650] ? trace_hardirqs_on_caller+0x310/0x310 [ 260.089670] ? prepare_exit_to_usermode+0x3b0/0x3b0 [ 260.094692] ? prepare_exit_to_usermode+0x291/0x3b0 [ 260.099712] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 260.104561] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 260.109744] RIP: 0033:0x457569 [ 260.112938] Code: fd b3 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 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 [ 260.131832] RSP: 002b:00007f1ecff72c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000141 [ 260.139539] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 [ 260.146808] RDX: 0000000000000028 RSI: 0000000020000080 RDI: 000000000000000a [ 260.154073] RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 [ 260.161338] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1ecff736d4 [ 260.168600] R13: 00000000004bd892 R14: 00000000004cc208 R15: 00000000ffffffff [ 260.175876] [ 260.175883] ====================================================== [ 260.175889] WARNING: possible circular locking dependency detected [ 260.175894] 4.19.0-rc8-next-20181019+ #98 Not tainted [ 260.175901] ------------------------------------------------------ [ 260.175907] syz-executor0/6962 is trying to acquire lock: [ 260.175910] 000000003e0d1f82 ((console_sem).lock){-.-.}, at: down_trylock+0x13/0x70 [ 260.175926] [ 260.175931] but task is already holding lock: [ 260.175934] 000000004ecab923 (&obj_hash[i].lock){-.-.}, at: __debug_object_init+0x127/0x1290 [ 260.175951] [ 260.175956] which lock already depends on the new lock. [ 260.175959] [ 260.175962] [ 260.175968] the existing dependency chain (in reverse order) is: [ 260.175970] [ 260.175973] -> #3 (&obj_hash[i].lock){-.-.}: [ 260.175989] _raw_spin_lock_irqsave+0x99/0xd0 [ 260.175994] __debug_object_init+0x127/0x1290 [ 260.175999] debug_object_init+0x16/0x20 [ 260.176004] hrtimer_init+0x97/0x490 [ 260.176009] init_dl_task_timer+0x1b/0x50 [ 260.176013] __sched_fork+0x2ae/0x590 [ 260.176017] init_idle+0x75/0x740 [ 260.176022] sched_init+0xb33/0xc02 [ 260.176026] start_kernel+0x4be/0xa2b [ 260.176032] x86_64_start_reservations+0x2e/0x30 [ 260.176036] x86_64_start_kernel+0x76/0x79 [ 260.176041] secondary_startup_64+0xa4/0xb0 [ 260.176044] [ 260.176047] -> #2 (&rq->lock){-.-.}: [ 260.176062] _raw_spin_lock+0x2d/0x40 [ 260.176067] task_fork_fair+0xb0/0x6d0 [ 260.176071] sched_fork+0x443/0xba0 [ 260.176075] copy_process+0x2585/0x8770 [ 260.176080] _do_fork+0x1cb/0x11c0 [ 260.176084] kernel_thread+0x34/0x40 [ 260.176089] rest_init+0x28/0x372 [ 260.176094] arch_call_rest_init+0xe/0x1b [ 260.176098] start_kernel+0x9f0/0xa2b [ 260.176103] x86_64_start_reservations+0x2e/0x30 [ 260.176108] x86_64_start_kernel+0x76/0x79 [ 260.176113] secondary_startup_64+0xa4/0xb0 [ 260.176116] [ 260.176118] -> #1 (&p->pi_lock){-.-.}: [ 260.176134] _raw_spin_lock_irqsave+0x99/0xd0 [ 260.176139] try_to_wake_up+0xd2/0x12e0 [ 260.176143] wake_up_process+0x10/0x20 [ 260.176148] __up.isra.1+0x1c0/0x2a0 [ 260.176152] up+0x13c/0x1c0 [ 260.176156] __up_console_sem+0xbe/0x1b0 [ 260.176161] console_unlock+0x80c/0x1190 [ 260.176166] vprintk_emit+0x391/0x990 [ 260.176170] vprintk_default+0x28/0x30 [ 260.176175] vprintk_func+0x7e/0x181 [ 260.176179] printk+0xa7/0xcf [ 260.176183] do_exit.cold.18+0x57/0x16f [ 260.176188] do_group_exit+0x177/0x440 [ 260.176193] __x64_sys_exit_group+0x3e/0x50 [ 260.176198] do_syscall_64+0x1b9/0x820 [ 260.176203] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 260.176206] [ 260.176208] -> #0 ((console_sem).lock){-.-.}: [ 260.176224] lock_acquire+0x1ed/0x520 [ 260.176229] _raw_spin_lock_irqsave+0x99/0xd0 [ 260.176234] down_trylock+0x13/0x70 [ 260.176239] __down_trylock_console_sem+0xae/0x1f0 [ 260.176244] console_trylock+0x15/0xa0 [ 260.176248] vprintk_emit+0x372/0x990 [ 260.176253] vprintk_default+0x28/0x30 [ 260.176257] vprintk_func+0x7e/0x181 [ 260.176261] printk+0xa7/0xcf [ 260.176267] __debug_object_init.cold.14+0x4a/0xdf [ 260.176272] debug_object_init+0x16/0x20 [ 260.176276] init_timer_key+0xa9/0x480 [ 260.176281] sock_init_data+0xe1/0xdc0 [ 260.176286] bpf_prog_test_run_skb+0x255/0xc40 [ 260.176291] bpf_prog_test_run+0x130/0x1a0 [ 260.176295] __x64_sys_bpf+0x3d8/0x510 [ 260.176300] do_syscall_64+0x1b9/0x820 [ 260.176306] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 260.176308] [ 260.176313] other info that might help us debug this: [ 260.176316] [ 260.176320] Chain exists of: [ 260.176322] (console_sem).lock --> &rq->lock --> &obj_hash[i].lock [ 260.176342] [ 260.176347] Possible unsafe locking scenario: [ 260.176350] [ 260.176354] CPU0 CPU1 [ 260.176359] ---- ---- [ 260.176362] lock(&obj_hash[i].lock); [ 260.176373] lock(&rq->lock); [ 260.176383] lock(&obj_hash[i].lock); [ 260.176401] lock((console_sem).lock); [ 260.176410] [ 260.176418] *** DEADLOCK *** [ 260.176421] [ 260.176426] 1 lock held by syz-executor0/6962: [ 260.176428] #0: 000000004ecab923 (&obj_hash[i].lock){-.-.}, at: __debug_object_init+0x127/0x1290 [ 260.176448] [ 260.176451] stack backtrace: [ 260.176459] CPU: 0 PID: 6962 Comm: syz-executor0 Not tainted 4.19.0-rc8-next-20181019+ #98 [ 260.176467] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 260.176471] Call Trace: [ 260.176475] dump_stack+0x244/0x39d [ 260.176481] ? dump_stack_print_info.cold.1+0x20/0x20 [ 260.176485] ? vprintk_func+0x85/0x181 [ 260.176491] print_circular_bug.isra.35.cold.54+0x1bd/0x27d [ 260.176496] ? save_trace+0xe0/0x290 [ 260.176500] __lock_acquire+0x3399/0x4c20 [ 260.176505] ? mark_held_locks+0x130/0x130 [ 260.176509] ? put_dec+0xf0/0xf0 [ 260.176514] ? mark_held_locks+0x130/0x130 [ 260.176519] ? pointer_string+0x14e/0x1b0 [ 260.176523] ? number+0xca0/0xca0 [ 260.176528] ? print_usage_bug+0xc0/0xc0 [ 260.176532] ? ptr_to_id+0xd0/0x1d0 [ 260.176536] ? dentry_name+0x8f0/0x8f0 [ 260.176541] ? is_bpf_text_address+0xac/0x170 [ 260.176546] ? zap_class+0x640/0x640 [ 260.176551] ? __sanitizer_cov_trace_const_cmp1+0x1a/0x20 [ 260.176556] lock_acquire+0x1ed/0x520 [ 260.176560] ? down_trylock+0x13/0x70 [ 260.176565] ? lock_release+0xa10/0xa10 [ 260.176570] ? trace_hardirqs_off+0xb8/0x310 [ 260.176574] ? vprintk_emit+0x1de/0x990 [ 260.176579] ? trace_hardirqs_on+0x310/0x310 [ 260.176584] ? trace_hardirqs_off+0xb8/0x310 [ 260.176589] ? log_store+0x344/0x4c0 [ 260.176593] ? vprintk_emit+0x372/0x990 [ 260.176598] _raw_spin_lock_irqsave+0x99/0xd0 [ 260.176603] ? down_trylock+0x13/0x70 [ 260.176607] down_trylock+0x13/0x70 [ 260.176612] __down_trylock_console_sem+0xae/0x1f0 [ 260.176617] console_trylock+0x15/0xa0 [ 260.176621] vprintk_emit+0x372/0x990 [ 260.176626] ? wake_up_klogd+0x180/0x180 [ 260.176630] ? zap_class+0x640/0x640 [ 260.176635] ? __switch_to_asm+0x34/0x70 [ 260.176639] ? __switch_to_asm+0x40/0x70 [ 260.176644] ? print_usage_bug+0xc0/0xc0 [ 260.176649] ? find_held_lock+0x36/0x1c0 [ 260.176653] vprintk_default+0x28/0x30 [ 260.176657] vprintk_func+0x7e/0x181 [ 260.176661] printk+0xa7/0xcf [ 260.176667] ? kmsg_dump_rewind_nolock+0xe4/0xe4 [ 260.176672] __debug_object_init.cold.14+0x4a/0xdf [ 260.176677] ? lockdep_hardirqs_on+0x3bb/0x5b0 [ 260.176682] ? debug_object_free+0x690/0x690 [ 260.176687] ? unwind_get_return_address+0x61/0xa0 [ 260.176693] ? _raw_spin_unlock_irqrestore+0x6d/0xd0 [ 260.176697] ? depot_save_stack+0x292/0x470 [ 260.176702] ? save_stack+0xa9/0xd0 [ 260.176706] ? save_stack+0x43/0xd0 [ 260.176711] ? kasan_kmalloc+0xc7/0xe0 [ 260.176716] ? bpf_test_init.isra.10+0x98/0x100 [ 260.176720] ? zap_class+0x640/0x640 [ 260.176725] ? do_syscall_64+0x1b9/0x820 [ 260.176730] ? entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 260.176735] ? find_held_lock+0x36/0x1c0 [ 260.176740] debug_object_init+0x16/0x20 [ 260.176744] init_timer_key+0xa9/0x480 [ 260.176749] ? init_timer_on_stack_key+0xe0/0xe0 [ 260.176754] ? __might_fault+0x12b/0x1e0 [ 260.176759] ? __lockdep_init_map+0x105/0x590 [ 260.176764] ? __lockdep_init_map+0x105/0x590 [ 260.176768] ? lockdep_init_map+0x9/0x10 [ 260.176773] sock_init_data+0xe1/0xdc0 [ 260.176777] ? sk_stop_timer+0x50/0x50 [ 260.176783] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 260.176788] ? _copy_from_user+0xdf/0x150 [ 260.176793] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 260.176799] ? bpf_test_init.isra.10+0x70/0x100 [ 260.176803] bpf_prog_test_run_skb+0x255/0xc40 [ 260.176808] ? __lock_acquire+0x62f/0x4c20 [ 260.176813] ? bpf_test_finish.isra.9+0x1f0/0x1f0 [ 260.176818] ? __lock_acquire+0x62f/0x4c20 [ 260.176822] ? fput+0x130/0x1a0 [ 260.176834] ? __bpf_prog_get+0x9b/0x290 [ 260.176839] ? bpf_test_finish.isra.9+0x1f0/0x1f0 [ 260.176844] bpf_prog_test_run+0x130/0x1a0 [ 260.176848] __x64_sys_bpf+0x3d8/0x510 [ 260.176858] ? bpf_prog_get+0x20/0x20 [ 260.176867] do_syscall_64+0x1b9/0x820 [ 260.176881] ? entry_SYSCALL_64_after_hwframe+0x3e/0xbe [ 260.176889] ? syscall_return_slowpath+0x5e0/0x5e0 [ 260.176894] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 260.176904] ? trace_hardirqs_on_caller+0x310/0x310 [ 260.176910] ? prepare_exit_to_usermode+0x3b0/0x3b0 [ 260.176923] ? prepare_exit_to_usermode+0x291/0x3b0 [ 260.176933] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 260.176938] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 260.176947] RIP: 0033:0x457569 [ 260.176966] Code: fd b3 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 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 [ 260.176971] RSP: 002b:00007f1ecff72c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000141 [ 260.176991] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 [ 260.176998] RDX: 0000000000000028 RSI: 0000000020000080 RDI: 000000000000000a [ 260.177009] RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 [ 260.177019] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1ecff736d4 [ 260.177026] R13: 00000000004bd892 R14: 00000000004cc208 R15: 00000000ffffffff [ 260.177920] Kernel Offset: disabled [ 261.075136] Rebooting in 86400 seconds..