Warning: Permanently added '10.128.0.207' (ECDSA) to the list of known hosts. 2020/12/01 21:03:16 parsed 1 programs 2020/12/01 21:03:17 executed programs: 0 [ 1579.689923] IPVS: ftp: loaded support on port[0] = 21 [ 1579.781993] chnl_net:caif_netlink_parms(): no params data found [ 1579.877339] bridge0: port 1(bridge_slave_0) entered blocking state [ 1579.883876] bridge0: port 1(bridge_slave_0) entered disabled state [ 1579.891899] device bridge_slave_0 entered promiscuous mode [ 1579.899468] bridge0: port 2(bridge_slave_1) entered blocking state [ 1579.906069] bridge0: port 2(bridge_slave_1) entered disabled state [ 1579.912940] device bridge_slave_1 entered promiscuous mode [ 1579.929161] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 1579.938379] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 1579.956637] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 1579.963768] team0: Port device team_slave_0 added [ 1579.969389] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 1579.976651] team0: Port device team_slave_1 added [ 1579.990949] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 1579.997262] 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. [ 1580.022510] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 1580.033814] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 1580.040109] 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. [ 1580.065425] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 1580.076249] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 1580.083459] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 1580.102100] device hsr_slave_0 entered promiscuous mode [ 1580.107748] device hsr_slave_1 entered promiscuous mode [ 1580.113568] IPv6: ADDRCONF(NETDEV_UP): hsr_slave_0: link is not ready [ 1580.120703] IPv6: ADDRCONF(NETDEV_UP): hsr_slave_1: link is not ready [ 1580.180648] bridge0: port 2(bridge_slave_1) entered blocking state [ 1580.187259] bridge0: port 2(bridge_slave_1) entered forwarding state [ 1580.194043] bridge0: port 1(bridge_slave_0) entered blocking state [ 1580.200455] bridge0: port 1(bridge_slave_0) entered forwarding state [ 1580.227985] IPv6: ADDRCONF(NETDEV_UP): bond0: link is not ready [ 1580.234092] 8021q: adding VLAN 0 to HW filter on device bond0 [ 1580.243197] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 1580.251984] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 1580.270420] bridge0: port 1(bridge_slave_0) entered disabled state [ 1580.277673] bridge0: port 2(bridge_slave_1) entered disabled state [ 1580.287593] IPv6: ADDRCONF(NETDEV_UP): team0: link is not ready [ 1580.293651] 8021q: adding VLAN 0 to HW filter on device team0 [ 1580.302700] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 1580.310544] bridge0: port 1(bridge_slave_0) entered blocking state [ 1580.316978] bridge0: port 1(bridge_slave_0) entered forwarding state [ 1580.327322] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 1580.335249] bridge0: port 2(bridge_slave_1) entered blocking state [ 1580.341586] bridge0: port 2(bridge_slave_1) entered forwarding state [ 1580.359570] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 1580.369460] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 1580.380826] IPv6: ADDRCONF(NETDEV_UP): hsr0: link is not ready [ 1580.388189] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 1580.396106] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 1580.403552] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 1580.411935] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 1580.420216] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 1580.427128] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 1580.439210] IPv6: ADDRCONF(NETDEV_UP): vxcan0: link is not ready [ 1580.446801] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 1580.453457] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 1580.464081] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 1580.516336] IPv6: ADDRCONF(NETDEV_UP): veth0_virt_wifi: link is not ready [ 1580.525837] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 1580.551348] IPv6: ADDRCONF(NETDEV_UP): veth0_vlan: link is not ready [ 1580.558564] IPv6: ADDRCONF(NETDEV_UP): vlan0: link is not ready [ 1580.566486] IPv6: ADDRCONF(NETDEV_UP): vlan1: link is not ready [ 1580.576028] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 1580.583387] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 1580.591554] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 1580.600251] device veth0_vlan entered promiscuous mode [ 1580.608732] device veth1_vlan entered promiscuous mode [ 1580.614505] IPv6: ADDRCONF(NETDEV_UP): macvlan0: link is not ready [ 1580.623074] IPv6: ADDRCONF(NETDEV_UP): macvlan1: link is not ready [ 1580.633918] IPv6: ADDRCONF(NETDEV_UP): veth0_macvtap: link is not ready [ 1580.643476] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 1580.650889] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 1580.658461] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 1580.668560] device veth0_macvtap entered promiscuous mode [ 1580.674545] IPv6: ADDRCONF(NETDEV_UP): macvtap0: link is not ready [ 1580.682937] device veth1_macvtap entered promiscuous mode [ 1580.691406] IPv6: ADDRCONF(NETDEV_UP): veth0_to_batadv: link is not ready [ 1580.700495] IPv6: ADDRCONF(NETDEV_UP): veth1_to_batadv: link is not ready [ 1580.710141] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 1580.717293] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 1580.725446] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 1580.735584] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 1580.742238] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 1580.765012] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 1581.725554] Bluetooth: hci0 command 0x0409 tx timeout [ 1583.805044] Bluetooth: hci0 command 0x041b tx timeout 2020/12/01 21:03:22 executed programs: 4 [ 1585.884786] Bluetooth: hci0 command 0x040f tx timeout [ 1587.964802] Bluetooth: hci0 command 0x0419 tx timeout 2020/12/01 21:03:27 executed programs: 10 2020/12/01 21:03:33 executed programs: 16 2020/12/01 21:03:38 executed programs: 22 [ 1704.924785] Bluetooth: hci0 command 0x0406 tx timeout [ 1861.564954] INFO: task syz-executor.0:8443 blocked for more than 140 seconds. [ 1861.572518] Not tainted 4.14.209-syzkaller #0 [ 1861.578503] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1861.586541] syz-executor.0 D28456 8443 8017 0x00000004 [ 1861.592177] Call Trace: [ 1861.594805] __schedule+0x88b/0x1de0 [ 1861.598526] ? io_schedule_timeout+0x140/0x140 [ 1861.603111] ? trace_hardirqs_on+0x10/0x10 [ 1861.607395] schedule+0x8d/0x1b0 [ 1861.610759] schedule_timeout+0x80a/0xe90 [ 1861.614939] ? _raw_spin_unlock_irq+0x24/0x80 [ 1861.619480] ? usleep_range+0x130/0x130 [ 1861.623443] ? wait_for_common+0x26a/0x430 [ 1861.627766] ? lock_acquire+0x170/0x3f0 [ 1861.631739] ? lock_downgrade+0x740/0x740 [ 1861.635922] ? _raw_spin_unlock_irq+0x24/0x80 [ 1861.640434] wait_for_common+0x272/0x430 [ 1861.644493] ? out_of_line_wait_on_atomic_t+0x1a0/0x1a0 [ 1861.649921] ? preempt_schedule_common+0x45/0xc0 [ 1861.654672] ? wake_up_q+0xd0/0xd0 [ 1861.658258] flush_work+0x3fe/0x770 [ 1861.661885] ? worker_thread+0xff0/0xff0 [ 1861.665986] ? flush_workqueue_prep_pwqs+0x470/0x470 [ 1861.671090] ? __cancel_work_timer+0x2c1/0x460 [ 1861.675718] __cancel_work_timer+0x321/0x460 [ 1861.680409] ? work_on_cpu_safe+0x70/0x70 [ 1861.684538] ? lock_acquire+0x170/0x3f0 [ 1861.688544] ? lock_downgrade+0x740/0x740 [ 1861.692687] ? _raw_spin_unlock_irqrestore+0x79/0xe0 [ 1861.697983] p9_fd_close+0x299/0x420 [ 1861.701710] p9_client_create+0x736/0x12c0 [ 1861.706560] ? p9_client_flush+0x4c0/0x4c0 [ 1861.710880] ? __lockdep_init_map+0x100/0x560 [ 1861.715409] ? __raw_spin_lock_init+0x28/0x100 [ 1861.720014] v9fs_session_init+0x1c5/0x1540 [ 1861.724315] ? pcpu_alloc+0xbe0/0xf50 [ 1861.728155] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 1861.733006] ? v9fs_show_options+0x6b0/0x6b0 [ 1861.737473] ? v9fs_mount+0x54/0x860 [ 1861.741200] ? rcu_lockdep_current_cpu_online+0xed/0x140 [ 1861.746681] ? rcu_read_lock_sched_held+0x16c/0x1d0 [ 1861.751690] ? kmem_cache_alloc_trace+0x36c/0x3d0 [ 1861.756565] v9fs_mount+0x73/0x860 [ 1861.760123] ? alloc_pages_current+0x15d/0x260 [ 1861.764776] ? __lockdep_init_map+0x100/0x560 [ 1861.769268] mount_fs+0x92/0x2a0 [ 1861.772630] vfs_kern_mount.part.0+0x5b/0x470 [ 1861.777167] do_mount+0xe53/0x2a00 [ 1861.780703] ? copy_mount_string+0x40/0x40 [ 1861.784984] ? rcu_read_lock_sched_held+0x16c/0x1d0 [ 1861.790006] ? copy_mnt_ns+0xa30/0xa30 [ 1861.793883] ? copy_mount_options+0x1fa/0x2f0 [ 1861.798437] ? copy_mnt_ns+0xa30/0xa30 [ 1861.802323] SyS_mount+0xa8/0x120 [ 1861.805828] ? copy_mnt_ns+0xa30/0xa30 [ 1861.809711] do_syscall_64+0x1d5/0x640 [ 1861.813587] entry_SYSCALL_64_after_hwframe+0x46/0xbb [ 1861.818817] RIP: 0033:0x45deb9 [ 1861.822016] RSP: 002b:00007f395914ac78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 [ 1861.829775] RAX: ffffffffffffffda RBX: 0000000000021840 RCX: 000000000045deb9 [ 1861.837440] RDX: 0000000020000240 RSI: 0000000020000200 RDI: 0000000000000000 [ 1861.844772] RBP: 000000000118c168 R08: 0000000020000580 R09: 0000000000000000 [ 1861.852040] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118c124 [ 1861.859356] R13: 00007ffc24715a4f R14: 00007f395914b9c0 R15: 000000000118c124 [ 1861.866691] [ 1861.866691] Showing all locks held in the system: [ 1861.873125] 1 lock held by khungtaskd/1531: [ 1861.877562] #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a [ 1861.886748] 1 lock held by in:imklog/7696: [ 1861.890984] #0: (&f->f_pos_lock){+.+.}, at: [] __fdget_pos+0x1fb/0x2b0 [ 1861.899440] 2 locks held by kworker/1:0/7987: [ 1861.903920] #0: ("events"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 [ 1861.912438] #1: ((&m->wq)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 [ 1861.920931] [ 1861.922570] ============================================= [ 1861.922570] [ 1861.929779] NMI backtrace for cpu 0 [ 1861.934016] CPU: 0 PID: 1531 Comm: khungtaskd Not tainted 4.14.209-syzkaller #0 [ 1861.941442] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1861.950794] Call Trace: [ 1861.953368] dump_stack+0x1b2/0x283 [ 1861.956976] nmi_cpu_backtrace.cold+0x57/0x93 [ 1861.961447] ? irq_force_complete_move.cold+0x89/0x89 [ 1861.966614] nmi_trigger_cpumask_backtrace+0x13a/0x17f [ 1861.971877] watchdog+0x5b9/0xb40 [ 1861.976801] ? hungtask_pm_notify+0x50/0x50 [ 1861.981112] kthread+0x30d/0x420 [ 1861.984454] ? kthread_create_on_node+0xd0/0xd0 [ 1861.989112] ret_from_fork+0x24/0x30 [ 1861.992936] Sending NMI from CPU 0 to CPUs 1: [ 1861.998077] NMI backtrace for cpu 1 [ 1861.998081] CPU: 1 PID: 8 Comm: rcu_preempt Not tainted 4.14.209-syzkaller #0 [ 1861.998086] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1861.998089] task: ffff8880b5414200 task.stack: ffff8880b5418000 [ 1861.998092] RIP: 0010:__switch_to_xtra+0x0/0x12f0 [ 1861.998095] RSP: 0018:ffff8880b541fb28 EFLAGS: 00000046 [ 1861.998100] RAX: ffff8880b5420000 RBX: ffff8880b5418000 RCX: 0000000000000000 [ 1861.998104] RDX: 1ffff11016a82843 RSI: ffff8880b5414200 RDI: ffff8880a17ca100 [ 1861.998107] RBP: ffff8880b5414200 R08: ffff8880a17ca4d8 R09: 0000000000000001 [ 1861.998111] R10: 0000000000000000 R11: 0000000000000001 R12: ffff8880a17ca100 [ 1861.998114] R13: ffff8880b5414218 R14: 0000000000000000 R15: ffff8880a17cb4c0 [ 1861.998118] FS: 0000000000000000(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000 [ 1861.998121] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1861.998125] CR2: 00007fe674a0d000 CR3: 00000000a2220000 CR4: 00000000001406e0 [ 1861.998128] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 1861.998132] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 1861.998134] Call Trace: [ 1861.998136] __switch_to+0x6f3/0xf60 [ 1861.998139] ? compat_start_thread+0x70/0x70 [ 1861.998141] __schedule+0x88b/0x1de0 [ 1861.998144] ? schedule_timeout+0x4a5/0xe90 [ 1861.998147] ? io_schedule_timeout+0x140/0x140 [ 1861.998149] ? _raw_spin_unlock_irqrestore+0x79/0xe0 [ 1861.998152] schedule+0x8d/0x1b0 [ 1861.998154] schedule_timeout+0x4af/0xe90 [ 1861.998157] ? _raw_spin_unlock_irqrestore+0x79/0xe0 [ 1861.998159] ? usleep_range+0x130/0x130 [ 1861.998162] ? _raw_spin_unlock_irqrestore+0x66/0xe0 [ 1861.998165] ? prepare_to_swait+0x115/0x2a0 [ 1861.998167] ? run_timer_softirq+0x5a0/0x5a0 [ 1861.998170] rcu_gp_kthread+0xc0a/0x1e60 [ 1861.998172] ? force_qs_rnp+0x4f0/0x4f0 [ 1861.998175] ? force_qs_rnp+0x4f0/0x4f0 [ 1861.998177] kthread+0x30d/0x420 [ 1861.998180] ? kthread_create_on_node+0xd0/0xd0 [ 1861.998182] ret_from_fork+0x24/0x30 [ 1861.998184] Code: ee ff ff 48 89 c7 e8 20 f8 ff ff bf 01 00 00 00 e8 e6 0e 1d 00 65 8b 05 8f c4 e4 7e 85 c0 74 01 c3 e8 c0 06 e3 ff c3 0f 1f 40 00 <48> b8 00 00 00 00 00 fc ff df 41 57 41 56 41 55 41 54 49 89 f4 [ 1861.999075] Kernel panic - not syncing: hung_task: blocked tasks [ 1862.214081] CPU: 0 PID: 1531 Comm: khungtaskd Not tainted 4.14.209-syzkaller #0 [ 1862.221530] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1862.230883] Call Trace: [ 1862.233491] dump_stack+0x1b2/0x283 [ 1862.237136] panic+0x1f9/0x42d [ 1862.240311] ? add_taint.cold+0x16/0x16 [ 1862.244281] watchdog+0x5ca/0xb40 [ 1862.247727] ? hungtask_pm_notify+0x50/0x50 [ 1862.252040] kthread+0x30d/0x420 [ 1862.255384] ? kthread_create_on_node+0xd0/0xd0 [ 1862.260053] ret_from_fork+0x24/0x30 [ 1862.264341] Kernel Offset: disabled [ 1862.267960] Rebooting in 86400 seconds..