Warning: Permanently added '10.128.10.31' (ED25519) to the list of known hosts. 2023/12/11 21:17:39 ignoring optional flag "sandboxArg"="0" 2023/12/11 21:17:39 parsed 1 programs 2023/12/11 21:17:39 executed programs: 0 [ 95.264107][ T4458] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 95.272477][ T4458] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 95.281452][ T4458] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 95.291072][ T4458] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 95.298919][ T4458] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 95.307286][ T4458] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 95.461373][ T5417] chnl_net:caif_netlink_parms(): no params data found [ 95.538173][ T5417] bridge0: port 1(bridge_slave_0) entered blocking state [ 95.545591][ T5417] bridge0: port 1(bridge_slave_0) entered disabled state [ 95.552839][ T5417] bridge_slave_0: entered allmulticast mode [ 95.560818][ T5417] bridge_slave_0: entered promiscuous mode [ 95.569252][ T5417] bridge0: port 2(bridge_slave_1) entered blocking state [ 95.576662][ T5417] bridge0: port 2(bridge_slave_1) entered disabled state [ 95.584566][ T5417] bridge_slave_1: entered allmulticast mode [ 95.591592][ T5417] bridge_slave_1: entered promiscuous mode [ 95.625896][ T5417] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 95.638423][ T5417] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 95.676516][ T5417] team0: Port device team_slave_0 added [ 95.686133][ T5417] team0: Port device team_slave_1 added [ 95.715626][ T5417] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 95.722623][ T5417] 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. [ 95.749445][ T5417] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 95.762432][ T5417] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 95.769596][ T5417] 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. [ 95.796014][ T5417] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 95.841506][ T5417] hsr_slave_0: entered promiscuous mode [ 95.848768][ T5417] hsr_slave_1: entered promiscuous mode [ 96.828547][ T5417] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 96.843154][ T5417] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 96.859077][ T5417] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 96.873265][ T5417] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 97.015241][ T5417] 8021q: adding VLAN 0 to HW filter on device bond0 [ 97.051128][ T5417] 8021q: adding VLAN 0 to HW filter on device team0 [ 97.070034][ T5076] bridge0: port 1(bridge_slave_0) entered blocking state [ 97.077300][ T5076] bridge0: port 1(bridge_slave_0) entered forwarding state [ 97.106887][ T5076] bridge0: port 2(bridge_slave_1) entered blocking state [ 97.114123][ T5076] bridge0: port 2(bridge_slave_1) entered forwarding state [ 97.355268][ T4458] Bluetooth: hci0: command 0x0409 tx timeout [ 97.411950][ T5417] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 97.491036][ T5417] veth0_vlan: entered promiscuous mode [ 97.511369][ T5417] veth1_vlan: entered promiscuous mode [ 97.573305][ T5417] veth0_macvtap: entered promiscuous mode [ 97.588958][ T5417] veth1_macvtap: entered promiscuous mode [ 97.633548][ T5417] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 97.658341][ T5417] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 97.680374][ T5417] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 97.691015][ T5417] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 97.702433][ T5417] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 97.713022][ T5417] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 97.822422][ T5076] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 97.840716][ T5076] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 97.882324][ T1090] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 97.893090][ T1090] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 99.446066][ T4458] Bluetooth: hci0: command 0x041b tx timeout 2023/12/11 21:17:45 executed programs: 3 [ 101.515438][ T4458] Bluetooth: hci0: command 0x040f tx timeout [ 103.594522][ T4458] Bluetooth: hci0: command 0x0419 tx timeout 2023/12/11 21:17:50 executed programs: 9 2023/12/11 21:17:55 executed programs: 15 2023/12/11 21:18:01 executed programs: 21 [ 120.293872][ T11] [ 120.296520][ T11] ====================================================== [ 120.303705][ T11] WARNING: possible circular locking dependency detected [ 120.311372][ T11] 6.7.0-rc4-syzkaller-00858-g70028b2e51c6 #0 Not tainted [ 120.318551][ T11] ------------------------------------------------------ [ 120.325664][ T11] kworker/u4:0/11 is trying to acquire lock: [ 120.331709][ T11] ffff888021182530 (&rs->rs_recv_lock){....}-{2:2}, at: rds_wake_sk_sleep+0x23/0xe0 [ 120.341118][ T11] [ 120.341118][ T11] but task is already holding lock: [ 120.348641][ T11] ffff8880287fd900 (&rm->m_rs_lock){....}-{2:2}, at: rds_send_remove_from_sock+0x155/0xa50 [ 120.358919][ T11] [ 120.358919][ T11] which lock already depends on the new lock. [ 120.358919][ T11] [ 120.369329][ T11] [ 120.369329][ T11] the existing dependency chain (in reverse order) is: [ 120.378525][ T11] [ 120.378525][ T11] -> #1 (&rm->m_rs_lock){....}-{2:2}: [ 120.386283][ T11] _raw_spin_lock_irqsave+0x3a/0x50 [ 120.392116][ T11] rds_message_put+0x1dd/0xc50 [ 120.397419][ T11] rds_inc_put+0x13c/0x1a0 [ 120.402461][ T11] rds_clear_recv_queue+0x14c/0x350 [ 120.408976][ T11] rds_release+0xdb/0x3c0 [ 120.413819][ T11] __sock_release+0xae/0x260 [ 120.419527][ T11] sock_close+0x1c/0x20 [ 120.424192][ T11] __fput+0x270/0xbb0 [ 120.428719][ T11] __fput_sync+0x47/0x50 [ 120.433535][ T11] __x64_sys_close+0x87/0xf0 [ 120.438912][ T11] do_syscall_64+0x40/0x110 [ 120.444050][ T11] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 120.450652][ T11] [ 120.450652][ T11] -> #0 (&rs->rs_recv_lock){....}-{2:2}: [ 120.458467][ T11] __lock_acquire+0x2433/0x3b20 [ 120.464395][ T11] lock_acquire+0x1ae/0x520 [ 120.469782][ T11] _raw_read_lock_irqsave+0x46/0x90 [ 120.475702][ T11] rds_wake_sk_sleep+0x23/0xe0 [ 120.481249][ T11] rds_send_remove_from_sock+0x1e9/0xa50 [ 120.487403][ T11] rds_send_path_drop_acked+0x2f4/0x3c0 [ 120.493557][ T11] rds_tcp_write_space+0x1b5/0x6d0 [ 120.499192][ T11] tcp_check_space+0x178/0x8d0 [ 120.504482][ T11] tcp_rcv_established+0x959/0x20e0 [ 120.510305][ T11] tcp_v4_do_rcv+0x68c/0xa10 [ 120.515420][ T11] __release_sock+0x132/0x3b0 [ 120.520623][ T11] release_sock+0x5a/0x1f0 [ 120.525642][ T11] rds_send_xmit+0x164f/0x2490 [ 120.531020][ T11] rds_send_worker+0x8f/0x2e0 [ 120.536342][ T11] process_one_work+0x886/0x15d0 [ 120.541876][ T11] worker_thread+0x8b9/0x1290 [ 120.547079][ T11] kthread+0x2c6/0x3a0 [ 120.551662][ T11] ret_from_fork+0x45/0x80 [ 120.556686][ T11] ret_from_fork_asm+0x11/0x20 [ 120.562074][ T11] [ 120.562074][ T11] other info that might help us debug this: [ 120.562074][ T11] [ 120.572467][ T11] Possible unsafe locking scenario: [ 120.572467][ T11] [ 120.579914][ T11] CPU0 CPU1 [ 120.585252][ T11] ---- ---- [ 120.590864][ T11] lock(&rm->m_rs_lock); [ 120.595282][ T11] lock(&rs->rs_recv_lock); [ 120.602471][ T11] lock(&rm->m_rs_lock); [ 120.609298][ T11] rlock(&rs->rs_recv_lock); [ 120.614153][ T11] [ 120.614153][ T11] *** DEADLOCK *** [ 120.614153][ T11] [ 120.622358][ T11] 5 locks held by kworker/u4:0/11: [ 120.627448][ T11] #0: ffff88814bfaa138 ((wq_completion)krdsd){+.+.}-{0:0}, at: process_one_work+0x789/0x15d0 [ 120.637974][ T11] #1: ffffc90000107d80 ((work_completion)(&(&cp->cp_send_w)->work)){+.+.}-{0:0}, at: process_one_work+0x7eb/0x15d0 [ 120.650565][ T11] #2: ffff8880263558b0 (k-sk_lock-AF_INET){+.+.}-{0:0}, at: tcp_sock_set_cork+0x1c/0x90 [ 120.660644][ T11] #3: ffff888026355b38 (k-clock-AF_INET){++.-}-{2:2}, at: rds_tcp_write_space+0x29/0x6d0 [ 120.670541][ T11] #4: ffff8880287fd900 (&rm->m_rs_lock){....}-{2:2}, at: rds_send_remove_from_sock+0x155/0xa50 [ 120.681220][ T11] [ 120.681220][ T11] stack backtrace: [ 120.687091][ T11] CPU: 1 PID: 11 Comm: kworker/u4:0 Not tainted 6.7.0-rc4-syzkaller-00858-g70028b2e51c6 #0 [ 120.697145][ T11] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 120.707278][ T11] Workqueue: krdsd rds_send_worker [ 120.712644][ T11] Call Trace: [ 120.716016][ T11] [ 120.718958][ T11] dump_stack_lvl+0xd9/0x1b0 [ 120.723544][ T11] check_noncircular+0x317/0x400 [ 120.728677][ T11] ? print_circular_bug+0x5c0/0x5c0 [ 120.733969][ T11] ? lockdep_lock+0xc6/0x200 [ 120.738560][ T11] ? hlock_class+0x130/0x130 [ 120.743160][ T11] ? is_dynamic_key+0x200/0x200 [ 120.748025][ T11] ? print_usage_bug.part.0+0x550/0x550 [ 120.753754][ T11] __lock_acquire+0x2433/0x3b20 [ 120.758957][ T11] ? lockdep_hardirqs_on_prepare+0x420/0x420 [ 120.764933][ T11] ? lockdep_hardirqs_on_prepare+0x420/0x420 [ 120.771087][ T11] lock_acquire+0x1ae/0x520 [ 120.775689][ T11] ? rds_wake_sk_sleep+0x23/0xe0 [ 120.780665][ T11] ? lock_sync+0x190/0x190 [ 120.785071][ T11] ? lock_sync+0x190/0x190 [ 120.789504][ T11] ? do_raw_spin_lock+0x12e/0x2b0 [ 120.794539][ T11] ? spin_bug+0x1d0/0x1d0 [ 120.798887][ T11] _raw_read_lock_irqsave+0x46/0x90 [ 120.804284][ T11] ? rds_wake_sk_sleep+0x23/0xe0 [ 120.809238][ T11] rds_wake_sk_sleep+0x23/0xe0 [ 120.814018][ T11] rds_send_remove_from_sock+0x1e9/0xa50 [ 120.819756][ T11] rds_send_path_drop_acked+0x2f4/0x3c0 [ 120.825332][ T11] ? rds_tcp_recv_exit+0x20/0x20 [ 120.831759][ T11] ? rds_send_remove_from_sock+0xa50/0xa50 [ 120.837741][ T11] ? sk_stream_wait_memory+0x1010/0x1010 [ 120.843763][ T11] rds_tcp_write_space+0x1b5/0x6d0 [ 120.848968][ T11] tcp_check_space+0x178/0x8d0 [ 120.853926][ T11] ? tcp_rbtree_insert+0x1f0/0x1f0 [ 120.859378][ T11] tcp_rcv_established+0x959/0x20e0 [ 120.864658][ T11] ? __release_sock+0xd4/0x3b0 [ 120.869544][ T11] ? tcp_check_space+0x8d0/0x8d0 [ 120.874479][ T11] tcp_v4_do_rcv+0x68c/0xa10 [ 120.879081][ T11] __release_sock+0x132/0x3b0 [ 120.883746][ T11] release_sock+0x5a/0x1f0 [ 120.888145][ T11] ? rds_tcp_xmit_path_prepare+0xa0/0xa0 [ 120.893768][ T11] rds_send_xmit+0x164f/0x2490 [ 120.898543][ T11] ? rds_atomic_send_complete+0x4a0/0x4a0 [ 120.904286][ T11] rds_send_worker+0x8f/0x2e0 [ 120.908994][ T11] process_one_work+0x886/0x15d0 [ 120.913949][ T11] ? wiphy_new_nm+0x2150/0x2150 [ 120.918907][ T11] ? workqueue_congested+0x300/0x300 [ 120.924319][ T11] ? assign_work+0x1a0/0x250 [ 120.928992][ T11] worker_thread+0x8b9/0x1290 [ 120.934328][ T11] ? process_one_work+0x15d0/0x15d0 [ 120.939618][ T11] kthread+0x2c6/0x3a0 [ 120.943684][ T11] ? _raw_spin_unlock_irq+0x23/0x50 [ 120.948867][ T11] ? kthread_complete_and_exit+0x40/0x40 [ 120.954505][ T11] ret_from_fork+0x45/0x80 [ 120.958932][ T11] ? kthread_complete_and_exit+0x40/0x40 [ 120.964587][ T11] ret_from_fork_asm+0x11/0x20 [ 120.969804][ T11] 2023/12/11 21:18:06 executed programs: 27 2023/12/11 21:18:11 executed programs: 33