Warning: Permanently added '10.128.10.45' (ECDSA) to the list of known hosts. 2020/12/24 13:46:39 parsed 1 programs 2020/12/24 13:46:39 executed programs: 0 [ 1585.890451] IPVS: ftp: loaded support on port[0] = 21 [ 1585.992723] chnl_net:caif_netlink_parms(): no params data found [ 1586.061670] bridge0: port 1(bridge_slave_0) entered blocking state [ 1586.070867] bridge0: port 1(bridge_slave_0) entered disabled state [ 1586.078289] device bridge_slave_0 entered promiscuous mode [ 1586.087698] bridge0: port 2(bridge_slave_1) entered blocking state [ 1586.094861] bridge0: port 2(bridge_slave_1) entered disabled state [ 1586.102085] device bridge_slave_1 entered promiscuous mode [ 1586.119582] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 1586.128653] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 1586.147142] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready [ 1586.154779] team0: Port device team_slave_0 added [ 1586.160902] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready [ 1586.168924] team0: Port device team_slave_1 added [ 1586.184286] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 1586.190595] 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. [ 1586.216114] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 1586.227576] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 1586.233928] 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. [ 1586.259275] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 1586.271157] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_0: link is not ready [ 1586.278594] IPv6: ADDRCONF(NETDEV_UP): bridge_slave_1: link is not ready [ 1586.298487] device hsr_slave_0 entered promiscuous mode [ 1586.304367] device hsr_slave_1 entered promiscuous mode [ 1586.310777] IPv6: ADDRCONF(NETDEV_UP): hsr_slave_0: link is not ready [ 1586.317831] IPv6: ADDRCONF(NETDEV_UP): hsr_slave_1: link is not ready [ 1586.385636] bridge0: port 2(bridge_slave_1) entered blocking state [ 1586.392088] bridge0: port 2(bridge_slave_1) entered forwarding state [ 1586.399344] bridge0: port 1(bridge_slave_0) entered blocking state [ 1586.406048] bridge0: port 1(bridge_slave_0) entered forwarding state [ 1586.437312] IPv6: ADDRCONF(NETDEV_UP): bond0: link is not ready [ 1586.445239] 8021q: adding VLAN 0 to HW filter on device bond0 [ 1586.454409] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready [ 1586.463596] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 1586.472420] bridge0: port 1(bridge_slave_0) entered disabled state [ 1586.479417] bridge0: port 2(bridge_slave_1) entered disabled state [ 1586.487319] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 1586.498526] IPv6: ADDRCONF(NETDEV_UP): team0: link is not ready [ 1586.505378] 8021q: adding VLAN 0 to HW filter on device team0 [ 1586.515250] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 1586.523884] bridge0: port 1(bridge_slave_0) entered blocking state [ 1586.530295] bridge0: port 1(bridge_slave_0) entered forwarding state [ 1586.539239] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 1586.547923] bridge0: port 2(bridge_slave_1) entered blocking state [ 1586.554331] bridge0: port 2(bridge_slave_1) entered forwarding state [ 1586.571060] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 1586.579271] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 1586.588771] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 1586.600556] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 1586.611277] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 1586.621224] IPv6: ADDRCONF(NETDEV_UP): hsr0: link is not ready [ 1586.627248] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 1586.641195] IPv6: ADDRCONF(NETDEV_UP): vxcan0: link is not ready [ 1586.648634] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 1586.656306] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 1586.667273] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 1586.679990] IPv6: ADDRCONF(NETDEV_UP): veth0_virt_wifi: link is not ready [ 1586.690955] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 1586.725102] IPv6: ADDRCONF(NETDEV_UP): veth0_vlan: link is not ready [ 1586.732662] IPv6: ADDRCONF(NETDEV_UP): vlan0: link is not ready [ 1586.739991] IPv6: ADDRCONF(NETDEV_UP): vlan1: link is not ready [ 1586.749079] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 1586.757764] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 1586.765052] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 1586.774575] device veth0_vlan entered promiscuous mode [ 1586.784371] device veth1_vlan entered promiscuous mode [ 1586.790782] IPv6: ADDRCONF(NETDEV_UP): macvlan0: link is not ready [ 1586.799276] IPv6: ADDRCONF(NETDEV_UP): macvlan1: link is not ready [ 1586.812409] IPv6: ADDRCONF(NETDEV_UP): veth0_macvtap: link is not ready [ 1586.823483] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 1586.833490] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 1586.841219] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 1586.851587] device veth0_macvtap entered promiscuous mode [ 1586.858858] IPv6: ADDRCONF(NETDEV_UP): macvtap0: link is not ready [ 1586.867257] device veth1_macvtap entered promiscuous mode [ 1586.876406] IPv6: ADDRCONF(NETDEV_UP): veth0_to_batadv: link is not ready [ 1586.885861] IPv6: ADDRCONF(NETDEV_UP): veth1_to_batadv: link is not ready [ 1586.895800] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 1586.903761] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 1586.912314] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 1586.922630] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 1586.930610] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 1587.044075] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 1587.051913] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 1587.064623] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 1587.075457] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 1587.085882] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready [ 1587.092754] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 1587.100041] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 1587.106860] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 1587.930699] Bluetooth: hci0: command 0x0409 tx timeout [ 1589.999746] Bluetooth: hci0: command 0x041b tx timeout 2020/12/24 13:46:45 executed programs: 4 [ 1592.079677] Bluetooth: hci0: command 0x040f tx timeout [ 1594.159233] Bluetooth: hci0: command 0x0419 tx timeout 2020/12/24 13:46:50 executed programs: 10 2020/12/24 13:46:56 executed programs: 16 2020/12/24 13:47:01 executed programs: 22 2020/12/24 13:47:06 executed programs: 28 2020/12/24 13:47:11 executed programs: 34 2020/12/24 13:47:16 executed programs: 40 2020/12/24 13:47:21 executed programs: 46 2020/12/24 13:47:26 executed programs: 52 2020/12/24 13:47:31 executed programs: 58 2020/12/24 13:47:37 executed programs: 64 2020/12/24 13:47:42 executed programs: 70 2020/12/24 13:47:47 executed programs: 76 2020/12/24 13:47:52 executed programs: 82 2020/12/24 13:47:57 executed programs: 88 2020/12/24 13:48:02 executed programs: 94 2020/12/24 13:48:07 executed programs: 100 2020/12/24 13:48:13 executed programs: 106 2020/12/24 13:48:18 executed programs: 112 2020/12/24 13:48:23 executed programs: 118 2020/12/24 13:48:28 executed programs: 124 [ 1712.951334] Bluetooth: hci0: command 0x0406 tx timeout [ 1843.983129] INFO: task syz-executor.0:9314 blocked for more than 140 seconds. [ 1843.990568] Not tainted 4.19.163-syzkaller #0 [ 1843.996978] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1844.005060] syz-executor.0 D28072 9314 8157 0x00000004 [ 1844.010694] Call Trace: [ 1844.014142] __schedule+0x887/0x2040 [ 1844.017985] ? io_schedule_timeout+0x140/0x140 [ 1844.022584] ? mark_held_locks+0xf0/0xf0 [ 1844.026853] schedule+0x8d/0x1b0 [ 1844.030204] schedule_timeout+0x92d/0xfe0 [ 1844.035178] ? lock_acquire+0x170/0x3c0 [ 1844.039208] ? finish_task_switch+0x118/0x780 [ 1844.043766] ? usleep_range+0x170/0x170 [ 1844.047743] ? wait_for_common+0x294/0x470 [ 1844.051963] ? lock_downgrade+0x720/0x720 [ 1844.056177] ? lock_acquire+0x170/0x3c0 [ 1844.060161] ? wait_for_common+0x9e/0x470 [ 1844.064373] ? _raw_spin_unlock_irq+0x24/0x80 [ 1844.068878] wait_for_common+0x29c/0x470 [ 1844.073096] ? __flush_work+0x37e/0x8b0 [ 1844.077346] ? bit_wait_io_timeout+0x100/0x100 [ 1844.081948] ? ___preempt_schedule+0x16/0x18 [ 1844.086439] ? wake_up_q+0xe0/0xe0 [ 1844.089980] ? ___preempt_schedule+0x16/0x18 [ 1844.094458] __flush_work+0x4bb/0x8b0 [ 1844.098262] ? alloc_unbound_pwq+0xc10/0xc10 [ 1844.102726] ? flush_workqueue_prep_pwqs+0x570/0x570 [ 1844.107940] ? _raw_spin_unlock_irq+0x5a/0x80 [ 1844.112553] ? __flush_work+0x4cf/0x8b0 [ 1844.116705] ? trace_hardirqs_off+0x64/0x200 [ 1844.121145] ? __cancel_work_timer+0x3ba/0x590 [ 1844.125794] __cancel_work_timer+0x412/0x590 [ 1844.130209] ? try_to_grab_pending+0x6f0/0x6f0 [ 1844.134860] ? lock_downgrade+0x720/0x720 [ 1844.139014] ? lock_acquire+0x170/0x3c0 [ 1844.143156] ? p9_fd_close+0x172/0x520 [ 1844.147045] ? _raw_spin_unlock_irqrestore+0x79/0xe0 [ 1844.152181] p9_fd_close+0x305/0x520 [ 1844.156309] p9_client_create+0x901/0x12e0 [ 1844.160600] ? setup_fault_attr+0x200/0x200 [ 1844.165620] ? p9_client_flush+0x490/0x490 [ 1844.169921] ? rcu_read_lock_sched_held+0x16c/0x1d0 [ 1844.175053] ? __lockdep_init_map+0x100/0x5a0 [ 1844.179807] ? __raw_spin_lock_init+0x28/0x100 [ 1844.184495] v9fs_session_init+0x1dd/0x1770 [ 1844.188877] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 1844.193795] ? v9fs_show_options+0x760/0x760 [ 1844.198202] ? setup_fault_attr+0x200/0x200 [ 1844.202505] ? lock_acquire+0x170/0x3c0 [ 1844.206575] ? check_preemption_disabled+0x41/0x280 [ 1844.211632] ? v9fs_mount+0x54/0x910 [ 1844.215408] ? rcu_read_lock_sched_held+0x16c/0x1d0 [ 1844.220468] ? kmem_cache_alloc_trace+0x323/0x380 [ 1844.225369] v9fs_mount+0x73/0x910 [ 1844.228963] ? alloc_pages_current+0x19b/0x2a0 [ 1844.233616] ? __lockdep_init_map+0x100/0x5a0 [ 1844.238169] mount_fs+0xa3/0x30c [ 1844.241583] vfs_kern_mount.part.0+0x68/0x470 [ 1844.246380] do_mount+0x113c/0x2f10 [ 1844.250058] ? do_raw_spin_unlock+0x171/0x230 [ 1844.254611] ? check_preemption_disabled+0x41/0x280 [ 1844.259647] ? copy_mount_string+0x40/0x40 [ 1844.263926] ? copy_mount_options+0x59/0x380 [ 1844.268334] ? rcu_read_lock_sched_held+0x16c/0x1d0 [ 1844.273426] ? kmem_cache_alloc_trace+0x323/0x380 [ 1844.278277] ? copy_mount_options+0x26f/0x380 [ 1844.283063] ksys_mount+0xcf/0x130 [ 1844.286623] __x64_sys_mount+0xba/0x150 [ 1844.290581] ? lockdep_hardirqs_on+0x3a8/0x5c0 [ 1844.296066] do_syscall_64+0xf9/0x620 [ 1844.300404] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 1844.305633] RIP: 0033:0x45e149 [ 1844.308830] Code: Bad RIP value. [ 1844.312177] RSP: 002b:00007fc4d7284c68 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 [ 1844.319944] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000000000045e149 [ 1844.327269] RDX: 0000000020000240 RSI: 0000000020000200 RDI: 0000000000000000 [ 1844.334614] RBP: 000000000119c1c8 R08: 0000000020000580 R09: 0000000000000000 [ 1844.341957] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000119c184 [ 1844.349289] R13: 00007ffebaf87a7f R14: 00007fc4d72859c0 R15: 000000000119c184 [ 1844.356650] [ 1844.356650] Showing all locks held in the system: [ 1844.363092] 1 lock held by khungtaskd/1568: [ 1844.367407] #0: 00000000dc0cc9cf (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 [ 1844.376100] 2 locks held by in:imklog/7807: [ 1844.380421] #0: 00000000ce96f4c1 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 [ 1844.388661] #1: 00000000e1c1a08e (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 [ 1844.396294] 2 locks held by kworker/0:0/8134: [ 1844.400821] #0: 000000009f79b485 ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 [ 1844.410149] #1: 0000000032351e74 ((work_completion)(&m->wq)){+.+.}, at: process_one_work+0x79c/0x1570 [ 1844.419689] [ 1844.421304] ============================================= [ 1844.421304] [ 1844.429000] NMI backtrace for cpu 1 [ 1844.432722] CPU: 1 PID: 1568 Comm: khungtaskd Not tainted 4.19.163-syzkaller #0 [ 1844.440173] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1844.449512] Call Trace: [ 1844.452136] dump_stack+0x1fc/0x2fe [ 1844.455758] nmi_cpu_backtrace.cold+0x63/0xa2 [ 1844.460270] ? lapic_can_unplug_cpu.cold+0x39/0x39 [ 1844.465191] nmi_trigger_cpumask_backtrace+0x1a6/0x1eb [ 1844.470589] watchdog+0x991/0xe60 [ 1844.474064] ? reset_hung_task_detector+0x30/0x30 [ 1844.478928] kthread+0x33f/0x460 [ 1844.482284] ? kthread_park+0x180/0x180 [ 1844.486253] ret_from_fork+0x24/0x30 [ 1844.490273] Sending NMI from CPU 1 to CPUs 0: [ 1844.495723] NMI backtrace for cpu 0 [ 1844.495728] CPU: 0 PID: 8435 Comm: kworker/u4:1 Not tainted 4.19.163-syzkaller #0 [ 1844.495734] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1844.495737] Workqueue: phy3 ieee80211_iface_work [ 1844.495742] RIP: 0010:__orc_find+0x58/0xf0 [ 1844.495752] Code: 00 00 fc ff df 49 89 fe 48 89 fd eb 0c 48 8d 6b 04 49 89 de 49 39 ec 72 4d 4c 89 e0 48 29 e8 48 89 c2 48 c1 e8 3f 48 c1 fa 02 <48> 01 d0 48 d1 f8 48 8d 5c 85 00 48 89 d8 48 c1 e8 03 42 0f b6 14 [ 1844.495756] RSP: 0018:ffff8880aa837860 EFLAGS: 00000006 [ 1844.495762] RAX: 0000000000000000 RBX: ffffffff8b889364 RCX: ffffffff88200193 [ 1844.495766] RDX: 0000000000000003 RSI: ffffffff8c112d52 RDI: ffffffff8b8892e8 [ 1844.495771] RBP: ffffffff8b889368 R08: ffffffff8c112f08 R09: ffffffff8c112d52 [ 1844.495775] R10: 0000000000074071 R11: 0000000000161d9d R12: ffffffff8b889374 [ 1844.495780] R13: ffffffff8b8892e8 R14: ffffffff8b889364 R15: dffffc0000000000 [ 1844.495784] FS: 0000000000000000(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 [ 1844.495788] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1844.495793] CR2: 00007f4f9495c008 CR3: 00000000a10aa000 CR4: 00000000001406f0 [ 1844.495797] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 1844.495802] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 1844.495804] Call Trace: [ 1844.495807] unwind_next_frame+0x33b/0x1c60 [ 1844.495810] ? ret_from_fork+0x24/0x30 [ 1844.495813] ? deref_stack_reg+0x1d0/0x1d0 [ 1844.495817] ? __save_stack_trace+0x9f/0x190 [ 1844.495820] ? ret_from_fork+0x24/0x30 [ 1844.495823] ? ieee80211_iface_work+0x289/0x8a0 [ 1844.495826] __save_stack_trace+0x9f/0x190 [ 1844.495829] ? ret_from_fork+0x24/0x30 [ 1844.495832] __kasan_slab_free+0x126/0x1f0 [ 1844.495835] ? kmem_cache_free+0x7f/0x260 [ 1844.495838] ? kfree_skbmem+0xc1/0x140 [ 1844.495841] ? kfree_skb+0x127/0x3d0 [ 1844.495844] ? ieee80211_iface_work+0x289/0x8a0 [ 1844.495848] ? process_one_work+0x864/0x1570 [ 1844.495851] ? worker_thread+0x64c/0x1130 [ 1844.495858] ? kthread+0x33f/0x460 [ 1844.495861] ? ret_from_fork+0x24/0x30 [ 1844.495864] ? debug_check_no_obj_freed+0x201/0x482 [ 1844.495868] ? debug_check_no_obj_freed+0x201/0x482 [ 1844.495871] ? lock_downgrade+0x720/0x720 [ 1844.495874] ? lock_acquire+0x170/0x3c0 [ 1844.495877] ? debug_check_no_obj_freed+0xb5/0x482 [ 1844.495880] ? trace_hardirqs_off+0x64/0x200 [ 1844.495884] ? _raw_spin_unlock_irqrestore+0x66/0xe0 [ 1844.495887] ? debug_check_no_obj_freed+0x201/0x482 [ 1844.495890] ? kfree_skbmem+0xc1/0x140 [ 1844.495893] kmem_cache_free+0x7f/0x260 [ 1844.495896] kfree_skbmem+0xc1/0x140 [ 1844.495899] kfree_skb+0x127/0x3d0 [ 1844.495902] ieee80211_iface_work+0x289/0x8a0 [ 1844.495905] process_one_work+0x864/0x1570 [ 1844.495908] ? pwq_dec_nr_in_flight+0x2d0/0x2d0 [ 1844.495911] worker_thread+0x64c/0x1130 [ 1844.495914] ? __kthread_parkme+0x133/0x1e0 [ 1844.495918] ? process_one_work+0x1570/0x1570 [ 1844.495920] kthread+0x33f/0x460 [ 1844.495923] ? kthread_park+0x180/0x180 [ 1844.495926] ret_from_fork+0x24/0x30 [ 1844.496011] Kernel panic - not syncing: hung_task: blocked tasks [ 1844.796020] CPU: 1 PID: 1568 Comm: khungtaskd Not tainted 4.19.163-syzkaller #0 [ 1844.803446] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 1844.812895] Call Trace: [ 1844.815474] dump_stack+0x1fc/0x2fe [ 1844.819161] panic+0x26a/0x50e [ 1844.822441] ? __warn_printk+0xf3/0xf3 [ 1844.826329] ? lapic_can_unplug_cpu.cold+0x39/0x39 [ 1844.831327] ? ___preempt_schedule+0x16/0x18 [ 1844.835806] ? watchdog+0x991/0xe60 [ 1844.839455] ? nmi_trigger_cpumask_backtrace+0x15e/0x1eb [ 1844.844989] watchdog+0x9a2/0xe60 [ 1844.848426] ? reset_hung_task_detector+0x30/0x30 [ 1844.853267] kthread+0x33f/0x460 [ 1844.856615] ? kthread_park+0x180/0x180 [ 1844.860591] ret_from_fork+0x24/0x30 [ 1844.865309] Kernel Offset: disabled [ 1844.868944] Rebooting in 86400 seconds..