Warning: Permanently added '10.128.1.57' (ED25519) to the list of known hosts. 2023/11/17 06:49:01 ignoring optional flag "sandboxArg"="0" 2023/11/17 06:49:01 parsed 1 programs 2023/11/17 06:49:03 executed programs: 0 [ 81.159344][ T5405] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k [ 81.211159][ T4456] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 81.219538][ T4456] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 81.227205][ T4456] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 81.236156][ T4456] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 81.243764][ T4456] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 81.251681][ T4456] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 81.365574][ T5412] chnl_net:caif_netlink_parms(): no params data found [ 81.419893][ T5412] bridge0: port 1(bridge_slave_0) entered blocking state [ 81.427114][ T5412] bridge0: port 1(bridge_slave_0) entered disabled state [ 81.434424][ T5412] bridge_slave_0: entered allmulticast mode [ 81.441135][ T5412] bridge_slave_0: entered promiscuous mode [ 81.449417][ T5412] bridge0: port 2(bridge_slave_1) entered blocking state [ 81.456485][ T5412] bridge0: port 2(bridge_slave_1) entered disabled state [ 81.464009][ T5412] bridge_slave_1: entered allmulticast mode [ 81.470900][ T5412] bridge_slave_1: entered promiscuous mode [ 81.494989][ T5412] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 81.506764][ T5412] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 81.534245][ T5412] team0: Port device team_slave_0 added [ 81.542360][ T5412] team0: Port device team_slave_1 added [ 81.564266][ T5412] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 81.571344][ T5412] 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. [ 81.597885][ T5412] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 81.610116][ T5412] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 81.617329][ T5412] 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. [ 81.643327][ T5412] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 81.679102][ T5412] hsr_slave_0: entered promiscuous mode [ 81.685240][ T5412] hsr_slave_1: entered promiscuous mode [ 81.870823][ T55] cfg80211: failed to load regulatory.db [ 82.422473][ T5412] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 82.433781][ T5412] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 82.445037][ T5412] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 82.456512][ T5412] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 82.551853][ T5412] 8021q: adding VLAN 0 to HW filter on device bond0 [ 82.575521][ T5412] 8021q: adding VLAN 0 to HW filter on device team0 [ 82.594251][ T9] bridge0: port 1(bridge_slave_0) entered blocking state [ 82.601548][ T9] bridge0: port 1(bridge_slave_0) entered forwarding state [ 82.622381][ T5073] bridge0: port 2(bridge_slave_1) entered blocking state [ 82.629607][ T5073] bridge0: port 2(bridge_slave_1) entered forwarding state [ 82.839466][ T5412] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 82.894519][ T5412] veth0_vlan: entered promiscuous mode [ 82.912667][ T5412] veth1_vlan: entered promiscuous mode [ 82.953758][ T5412] veth0_macvtap: entered promiscuous mode [ 82.965218][ T5412] veth1_macvtap: entered promiscuous mode [ 82.991422][ T5412] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 83.008307][ T5412] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 83.022015][ T5412] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.032836][ T5412] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.042870][ T5412] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.054427][ T5412] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.139971][ T5445] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 83.156496][ T5445] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 83.195263][ T1086] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 83.206809][ T1086] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 83.272248][ T5475] loop0: detected capacity change from 0 to 64 [ 83.308502][ T5062] Bluetooth: hci0: command 0x0409 tx timeout [ 83.362070][ T2918] [ 83.364526][ T2918] ============================================ [ 83.370939][ T2918] WARNING: possible recursive locking detected [ 83.377195][ T2918] 6.7.0-rc1-syzkaller-00125-g7475e51b8796 #0 Not tainted [ 83.384400][ T2918] -------------------------------------------- [ 83.390555][ T2918] kworker/u4:11/2918 is trying to acquire lock: [ 83.396800][ T2918] ffff888026a380b0 (&tree->tree_lock/1){+.+.}-{3:3}, at: hfs_find_init+0x16e/0x1f0 [ 83.406155][ T2918] [ 83.406155][ T2918] but task is already holding lock: [ 83.413613][ T2918] ffff888026a380b0 (&tree->tree_lock/1){+.+.}-{3:3}, at: hfs_find_init+0x16e/0x1f0 [ 83.422968][ T2918] [ 83.422968][ T2918] other info that might help us debug this: [ 83.431036][ T2918] Possible unsafe locking scenario: [ 83.431036][ T2918] [ 83.438573][ T2918] CPU0 [ 83.441866][ T2918] ---- [ 83.445148][ T2918] lock(&tree->tree_lock/1); [ 83.449859][ T2918] lock(&tree->tree_lock/1); [ 83.454558][ T2918] [ 83.454558][ T2918] *** DEADLOCK *** [ 83.454558][ T2918] [ 83.462885][ T2918] May be due to missing lock nesting notation [ 83.462885][ T2918] [ 83.471209][ T2918] 4 locks held by kworker/u4:11/2918: [ 83.476584][ T2918] #0: ffff88801ae45d38 ((wq_completion)writeback){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1420 [ 83.488132][ T2918] #1: ffffc9000a447d20 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1420 [ 83.500790][ T2918] #2: ffff888026a380b0 (&tree->tree_lock/1){+.+.}-{3:3}, at: hfs_find_init+0x16e/0x1f0 [ 83.510611][ T2918] #3: ffff88807efb80f8 (&HFS_I(tree->inode)->extents_lock){+.+.}-{3:3}, at: hfs_extend_file+0xff/0x1440 [ 83.522043][ T2918] [ 83.522043][ T2918] stack backtrace: [ 83.528037][ T2918] CPU: 0 PID: 2918 Comm: kworker/u4:11 Not tainted 6.7.0-rc1-syzkaller-00125-g7475e51b8796 #0 [ 83.538388][ T2918] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 83.548464][ T2918] Workqueue: writeback wb_workfn (flush-7:0) [ 83.554577][ T2918] Call Trace: [ 83.557872][ T2918] [ 83.560818][ T2918] dump_stack_lvl+0x1e7/0x2d0 [ 83.565767][ T2918] ? nf_tcp_handle_invalid+0x650/0x650 [ 83.571422][ T2918] ? print_deadlock_bug+0x46f/0x610 [ 83.577010][ T2918] ? _find_first_zero_bit+0xd4/0x100 [ 83.582411][ T2918] validate_chain+0x15b8/0x59f0 [ 83.587292][ T2918] ? __lock_acquire+0x1345/0x1fd0 [ 83.592341][ T2918] ? reacquire_held_locks+0x690/0x690 [ 83.597743][ T2918] ? mark_lock+0x9a/0x350 [ 83.602085][ T2918] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 83.608087][ T2918] ? print_irqtrace_events+0x220/0x220 [ 83.613564][ T2918] ? mark_lock+0x9a/0x350 [ 83.617994][ T2918] __lock_acquire+0x1345/0x1fd0 [ 83.622866][ T2918] lock_acquire+0x1e3/0x530 [ 83.627390][ T2918] ? hfs_find_init+0x16e/0x1f0 [ 83.632181][ T2918] ? read_lock_is_recursive+0x20/0x20 [ 83.637572][ T2918] ? wb_writeback+0x44d/0xc70 [ 83.642262][ T2918] ? wb_workfn+0x400/0xfb0 [ 83.646701][ T2918] ? __might_sleep+0xe0/0xe0 [ 83.651346][ T2918] ? ret_from_fork_asm+0x11/0x20 [ 83.656311][ T2918] __mutex_lock+0x136/0xd60 [ 83.660863][ T2918] ? hfs_find_init+0x16e/0x1f0 [ 83.665649][ T2918] ? hfs_find_init+0x16e/0x1f0 [ 83.670440][ T2918] ? mutex_lock_nested+0x20/0x20 [ 83.675408][ T2918] ? hfs_find_init+0x90/0x1f0 [ 83.680134][ T2918] ? rcu_is_watching+0x15/0xb0 [ 83.684916][ T2918] ? hfs_find_init+0x90/0x1f0 [ 83.689686][ T2918] ? trace_kmalloc+0x1f/0xa0 [ 83.694295][ T2918] ? __kmalloc+0xd0/0x1a0 [ 83.698637][ T2918] hfs_find_init+0x16e/0x1f0 [ 83.703259][ T2918] hfs_extend_file+0x31b/0x1440 [ 83.708127][ T2918] ? hfs_get_block+0xb60/0xb60 [ 83.712908][ T2918] ? rcu_is_watching+0x15/0xb0 [ 83.717709][ T2918] ? trace_contention_end+0x3c/0x100 [ 83.723105][ T2918] ? hfs_brec_find+0x197/0x570 [ 83.727894][ T2918] ? hfs_find_init+0x16e/0x1f0 [ 83.732860][ T2918] hfs_bmap_reserve+0xd9/0x3f0 [ 83.737733][ T2918] __hfs_ext_write_extent+0x22e/0x4f0 [ 83.743125][ T2918] hfs_ext_write_extent+0x154/0x1d0 [ 83.748343][ T2918] ? hfs_ext_keycmp+0x310/0x310 [ 83.753223][ T2918] hfs_write_inode+0xbc/0xec0 [ 83.757920][ T2918] ? hfs_inode_write_fork+0x1a0/0x1a0 [ 83.763328][ T2918] ? __writeback_single_inode+0x4ac/0xfc0 [ 83.769169][ T2918] ? do_raw_spin_unlock+0x13b/0x8b0 [ 83.774399][ T2918] __writeback_single_inode+0x69b/0xfc0 [ 83.780062][ T2918] writeback_sb_inodes+0x8e3/0x1220 [ 83.785287][ T2918] ? __lock_acquire+0x1fd0/0x1fd0 [ 83.790507][ T2918] ? do_raw_spin_lock+0x14e/0x370 [ 83.795661][ T2918] ? queue_io+0x570/0x570 [ 83.800025][ T2918] ? __writeback_inodes_wb+0x260/0x260 [ 83.805517][ T2918] ? queue_io+0x3d5/0x570 [ 83.810399][ T2918] wb_writeback+0x44d/0xc70 [ 83.814977][ T2918] ? percpu_ref_tryget+0x260/0x260 [ 83.820120][ T2918] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 83.826302][ T2918] wb_workfn+0x400/0xfb0 [ 83.830578][ T2918] ? inode_wait_for_writeback+0x290/0x290 [ 83.836327][ T2918] ? read_lock_is_recursive+0x20/0x20 [ 83.841728][ T2918] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 83.847737][ T2918] ? print_irqtrace_events+0x220/0x220 [ 83.853229][ T2918] ? process_scheduled_works+0x825/0x1420 [ 83.858972][ T2918] process_scheduled_works+0x90f/0x1420 [ 83.864652][ T2918] ? assign_work+0x3d0/0x3d0 [ 83.869439][ T2918] ? assign_work+0x364/0x3d0 [ 83.874056][ T2918] worker_thread+0xa5f/0x1000 [ 83.879020][ T2918] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 83.884944][ T2918] kthread+0x2d3/0x370 [ 83.889034][ T2918] ? pr_cont_work+0x5e0/0x5e0 [ 83.893740][ T2918] ? kthread_blkcg+0xd0/0xd0 [ 83.898350][ T2918] ret_from_fork+0x48/0x80 [ 83.902872][ T2918] ? kthread_blkcg+0xd0/0xd0 [ 83.907565][ T2918] ret_from_fork_asm+0x11/0x20 [ 83.912358][ T2918] [ 85.387827][ T5062] Bluetooth: hci0: command 0x041b tx timeout [ 87.467539][ T5062] Bluetooth: hci0: command 0x040f tx timeout [ 89.547709][ T5062] Bluetooth: hci0: command 0x0419 tx timeout