Warning: Permanently added '10.128.1.112' (ED25519) to the list of known hosts. 2024/10/18 18:41:22 ignoring optional flag "sandboxArg"="0" 2024/10/18 18:41:22 ignoring optional flag "type"="gce" 2024/10/18 18:41:22 parsed 1 programs [ 105.695114][ T5688] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k [ 108.254061][ T1100] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 108.263454][ T1100] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 108.285060][ T1100] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 108.293330][ T1100] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 108.531486][ T4619] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 108.540960][ T4619] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 108.548572][ T4619] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 108.566253][ T4619] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 108.574389][ T4619] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 108.581957][ T4619] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 109.637772][ T5737] chnl_net:caif_netlink_parms(): no params data found [ 109.724531][ T5737] bridge0: port 1(bridge_slave_0) entered blocking state [ 109.731835][ T5737] bridge0: port 1(bridge_slave_0) entered disabled state [ 109.739000][ T5737] bridge_slave_0: entered allmulticast mode [ 109.748210][ T5737] bridge_slave_0: entered promiscuous mode [ 109.755990][ T5737] bridge0: port 2(bridge_slave_1) entered blocking state [ 109.763514][ T5737] bridge0: port 2(bridge_slave_1) entered disabled state [ 109.773363][ T5737] bridge_slave_1: entered allmulticast mode [ 109.780340][ T5737] bridge_slave_1: entered promiscuous mode [ 109.808042][ T5737] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 109.819956][ T5737] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 109.847538][ T5737] team0: Port device team_slave_0 added [ 109.856429][ T5737] team0: Port device team_slave_1 added [ 109.880719][ T5737] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 109.887684][ T5737] 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. [ 109.914378][ T5737] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 109.929217][ T5737] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 109.936332][ T5737] 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. [ 109.962798][ T5737] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 109.998852][ T5737] hsr_slave_0: entered promiscuous mode [ 110.005851][ T5737] hsr_slave_1: entered promiscuous mode [ 110.535469][ T5737] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 110.547192][ T5737] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 110.557196][ T5737] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 110.568452][ T5737] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 110.638645][ T5737] 8021q: adding VLAN 0 to HW filter on device bond0 [ 110.659090][ T5737] 8021q: adding VLAN 0 to HW filter on device team0 [ 110.683924][ T35] bridge0: port 1(bridge_slave_0) entered blocking state [ 110.691078][ T35] bridge0: port 1(bridge_slave_0) entered forwarding state [ 110.707409][ T11] bridge0: port 2(bridge_slave_1) entered blocking state [ 110.714676][ T11] bridge0: port 2(bridge_slave_1) entered forwarding state [ 110.913875][ T5737] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 110.964123][ T5737] veth0_vlan: entered promiscuous mode [ 110.976617][ T5737] veth1_vlan: entered promiscuous mode [ 111.013422][ T5737] veth0_macvtap: entered promiscuous mode [ 111.024017][ T5737] veth1_macvtap: entered promiscuous mode [ 111.043519][ T5737] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 111.063799][ T5737] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 111.077145][ T5737] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 111.087539][ T5737] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 111.098038][ T5737] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 111.107216][ T5737] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 111.237728][ T11] netdevsim netdevsim0 netdevsim3 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 111.342012][ T11] netdevsim netdevsim0 netdevsim2 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 111.431620][ T11] netdevsim netdevsim0 netdevsim1 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 111.505713][ T11] netdevsim netdevsim0 netdevsim0 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 2024/10/18 18:41:36 executed programs: 0 [ 113.122032][ T55] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 113.133737][ T55] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 113.149854][ T55] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 113.158669][ T55] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 113.166699][ T55] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 113.174526][ T55] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 113.343212][ T5875] chnl_net:caif_netlink_parms(): no params data found [ 113.444730][ T5875] bridge0: port 1(bridge_slave_0) entered blocking state [ 113.452712][ T5875] bridge0: port 1(bridge_slave_0) entered disabled state [ 113.460540][ T5875] bridge_slave_0: entered allmulticast mode [ 113.467709][ T5875] bridge_slave_0: entered promiscuous mode [ 113.477345][ T5875] bridge0: port 2(bridge_slave_1) entered blocking state [ 113.485255][ T5875] bridge0: port 2(bridge_slave_1) entered disabled state [ 113.492925][ T5875] bridge_slave_1: entered allmulticast mode [ 113.500281][ T5875] bridge_slave_1: entered promiscuous mode [ 113.528637][ T5875] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 113.542355][ T5875] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 113.582401][ T5875] team0: Port device team_slave_0 added [ 113.592639][ T5875] team0: Port device team_slave_1 added [ 113.618390][ T5875] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 113.625560][ T5875] 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. [ 113.653087][ T5875] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 113.666275][ T5875] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 113.674952][ T5875] 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. [ 113.701102][ T5875] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 113.746997][ T5875] hsr_slave_0: entered promiscuous mode [ 113.756617][ T5875] hsr_slave_1: entered promiscuous mode [ 113.763288][ T5875] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 113.773599][ T5875] Cannot create hsr debugfs directory [ 114.162245][ T11] bridge_slave_1: left allmulticast mode [ 114.167937][ T11] bridge_slave_1: left promiscuous mode [ 114.174407][ T11] bridge0: port 2(bridge_slave_1) entered disabled state [ 114.187072][ T11] bridge_slave_0: left allmulticast mode [ 114.194431][ T11] bridge_slave_0: left promiscuous mode [ 114.202685][ T11] bridge0: port 1(bridge_slave_0) entered disabled state [ 114.459436][ T11] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 114.472409][ T11] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 114.482746][ T11] bond0 (unregistering): Released all slaves [ 114.599400][ T11] hsr_slave_0: left promiscuous mode [ 114.605617][ T11] hsr_slave_1: left promiscuous mode [ 114.619187][ T11] batman_adv: batadv0: Interface deactivated: batadv_slave_0 [ 114.627936][ T11] batman_adv: batadv0: Removing interface: batadv_slave_0 [ 114.638758][ T11] batman_adv: batadv0: Interface deactivated: batadv_slave_1 [ 114.646522][ T11] batman_adv: batadv0: Removing interface: batadv_slave_1 [ 114.664738][ T11] veth1_macvtap: left promiscuous mode [ 114.670592][ T11] veth0_macvtap: left promiscuous mode [ 114.676198][ T11] veth1_vlan: left promiscuous mode [ 114.682021][ T11] veth0_vlan: left promiscuous mode [ 115.074846][ T11] team0 (unregistering): Port device team_slave_1 removed [ 115.103739][ T11] team0 (unregistering): Port device team_slave_0 removed [ 115.230640][ T55] Bluetooth: hci0: command tx timeout [ 115.559309][ T5875] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 115.569460][ T5875] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 115.582252][ T5875] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 115.597286][ T5875] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 115.692786][ T5875] 8021q: adding VLAN 0 to HW filter on device bond0 [ 115.716819][ T5875] 8021q: adding VLAN 0 to HW filter on device team0 [ 115.732024][ T1100] bridge0: port 1(bridge_slave_0) entered blocking state [ 115.739277][ T1100] bridge0: port 1(bridge_slave_0) entered forwarding state [ 115.763535][ T1100] bridge0: port 2(bridge_slave_1) entered blocking state [ 115.770801][ T1100] bridge0: port 2(bridge_slave_1) entered forwarding state [ 116.309267][ T5875] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 116.368982][ T5875] veth0_vlan: entered promiscuous mode [ 116.385393][ T5875] veth1_vlan: entered promiscuous mode [ 116.418586][ T5875] veth0_macvtap: entered promiscuous mode [ 116.431589][ T5875] veth1_macvtap: entered promiscuous mode [ 116.459532][ T5875] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 116.472348][ T5875] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 116.482561][ T5875] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 116.492984][ T5875] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 116.502089][ T5875] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 116.513493][ T5875] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 116.601189][ T35] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 116.609046][ T35] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 116.635815][ T12] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 116.643950][ T12] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 117.029602][ T6001] loop0: detected capacity change from 0 to 32768 [ 117.037513][ T6001] ======================================================= [ 117.037513][ T6001] WARNING: The mand mount option has been deprecated and [ 117.037513][ T6001] and is ignored by this kernel. Remove the mand [ 117.037513][ T6001] option from the mount to silence this warning. [ 117.037513][ T6001] ======================================================= [ 117.255904][ T6001] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=errors=continue,compression=zstd,norecovery,recovery_pass_last=check_dirents,nojournal_transaction_names,version_upgrade=none [ 117.309969][ T55] Bluetooth: hci0: command tx timeout [ 117.330961][ T6001] bcachefs (loop0): recovering from clean shutdown, journal seq 7 [ 117.378770][ T6001] invalid bkey u64s 11 type alloc_v4 0:14:0 len 0 ver 0: [ 117.378800][ T6001] gen 0 oldest_gen 0 data_type journal [ 117.378814][ T6001] journal_seq 1 [ 117.378828][ T6001] need_discard 1 [ 117.378841][ T6001] need_inc_gen 1 [ 117.378854][ T6001] dirty_sectors 256 [ 117.378867][ T6001] stripe_sectors 0 [ 117.378880][ T6001] cached_sectors 0 [ 117.378893][ T6001] stripe 67108864 [ 117.378911][ T6001] stripe_redundancy 0 [ 117.378924][ T6001] io_time[READ] 1 [ 117.378938][ T6001] io_time[WRITE] 1 [ 117.378951][ T6001] fragmentation 0 [ 117.378964][ T6001] bp_start 8 [ 117.378977][ T6001] [ 117.378989][ T6001] invalid data type (got 2 should be 7): delete?, fixing [ 117.545339][ T6001] bcachefs (loop0): accounting_read... done [ 117.554717][ T6001] bcachefs (loop0): alloc_read... done [ 117.560582][ T6001] bcachefs (loop0): stripes_read... done [ 117.566493][ T6001] bcachefs (loop0): snapshots_read... done [ 117.578039][ T6001] bcachefs (loop0): going read-write [ 117.601355][ T6001] bcachefs (loop0): Fixed errors, running fsck a second time to verify fs is clean [ 117.618523][ T6001] bcachefs (loop0): done starting filesystem [ 117.666517][ T5875] bcachefs (loop0): shutting down [ 117.673751][ T5875] bcachefs (loop0): going read-only [ 117.679192][ T5875] bcachefs (loop0): finished waiting for writes to stop [ 119.391141][ T55] Bluetooth: hci0: command tx timeout [ 121.470070][ T55] Bluetooth: hci0: command tx timeout [ 127.748960][ T4619] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1 [ 127.761442][ T4619] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9 [ 127.769499][ T4619] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9 [ 127.778076][ T4619] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4 [ 127.787096][ T4619] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3 [ 127.794865][ T4619] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2 [ 127.911134][ T6141] chnl_net:caif_netlink_parms(): no params data found [ 127.963671][ T6141] bridge0: port 1(bridge_slave_0) entered blocking state [ 127.970940][ T6141] bridge0: port 1(bridge_slave_0) entered disabled state [ 127.978077][ T6141] bridge_slave_0: entered allmulticast mode [ 127.985420][ T6141] bridge_slave_0: entered promiscuous mode [ 127.993255][ T6141] bridge0: port 2(bridge_slave_1) entered blocking state [ 128.000672][ T6141] bridge0: port 2(bridge_slave_1) entered disabled state [ 128.007826][ T6141] bridge_slave_1: entered allmulticast mode [ 128.016031][ T6141] bridge_slave_1: entered promiscuous mode [ 128.041798][ T6141] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 128.053110][ T6141] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 128.080172][ T6141] team0: Port device team_slave_0 added [ 128.087529][ T6141] team0: Port device team_slave_1 added [ 128.110156][ T6141] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 128.117153][ T6141] 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. [ 128.143894][ T6141] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 128.157322][ T6141] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 128.164356][ T6141] 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. [ 128.190322][ T6141] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 128.226561][ T6141] hsr_slave_0: entered promiscuous mode [ 128.233159][ T6141] hsr_slave_1: entered promiscuous mode [ 128.314792][ T6141] netdevsim netdevsim0 netdevsim3 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 128.351183][ T6141] netdevsim netdevsim0 netdevsim2 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 128.413031][ T6141] netdevsim netdevsim0 netdevsim1 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 128.483774][ T6141] netdevsim netdevsim0 netdevsim0 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 128.594268][ T6141] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 128.609140][ T6141] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 128.619185][ T6141] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 128.628198][ T6141] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 128.648343][ T6141] bridge0: port 2(bridge_slave_1) entered blocking state [ 128.655483][ T6141] bridge0: port 2(bridge_slave_1) entered forwarding state [ 128.662934][ T6141] bridge0: port 1(bridge_slave_0) entered blocking state [ 128.670106][ T6141] bridge0: port 1(bridge_slave_0) entered forwarding state [ 128.720727][ T6141] 8021q: adding VLAN 0 to HW filter on device bond0 [ 128.735211][ T35] bridge0: port 1(bridge_slave_0) entered disabled state [ 128.744598][ T35] bridge0: port 2(bridge_slave_1) entered disabled state [ 128.760533][ T6141] 8021q: adding VLAN 0 to HW filter on device team0 [ 128.773124][ T1100] bridge0: port 1(bridge_slave_0) entered blocking state [ 128.780368][ T1100] bridge0: port 1(bridge_slave_0) entered forwarding state [ 128.793604][ T35] bridge0: port 2(bridge_slave_1) entered blocking state [ 128.800815][ T35] bridge0: port 2(bridge_slave_1) entered forwarding state [ 128.953011][ T6141] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 128.987654][ T6141] veth0_vlan: entered promiscuous mode [ 128.998471][ T6141] veth1_vlan: entered promiscuous mode [ 129.023228][ T6141] veth0_macvtap: entered promiscuous mode [ 129.035033][ T6141] veth1_macvtap: entered promiscuous mode [ 129.048422][ T6141] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_0 [ 129.059519][ T6141] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 129.071915][ T6141] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 129.084673][ T6141] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3f) already exists on: batadv_slave_1 [ 129.095472][ T6141] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 129.109334][ T6141] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 129.124858][ T6141] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 129.134188][ T6141] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 129.143418][ T6141] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 129.153256][ T6141] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 129.208699][ T12] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 129.222826][ T12] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 129.244686][ T35] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 2024/10/18 18:41:52 executed programs: 4 [ 129.254451][ T35] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 129.869964][ T55] Bluetooth: hci1: command tx timeout [ 131.949827][ T55] Bluetooth: hci1: command tx timeout [ 132.283766][ T1254] ieee802154 phy0 wpan0: encryption failed: -22 [ 132.290225][ T1254] ieee802154 phy1 wpan1: encryption failed: -22 [ 134.030788][ T55] Bluetooth: hci1: command tx timeout 2024/10/18 18:41:57 executed programs: 20 [ 136.109854][ T55] Bluetooth: hci1: command tx timeout 2024/10/18 18:42:02 executed programs: 36 2024/10/18 18:42:07 executed programs: 52 [ 147.640659][ T6033] Allocator stuck? Waited for 30 seconds [ 147.640682][ T6033] Allocator debug: [ 147.640694][ T6033] capacity1536 [ 147.640706][ T6033] reserved 31232 [ 147.640719][ T6033] hidden 0 [ 147.640732][ T6033] btree 0 [ 147.640744][ T6033] data 0 [ 147.640757][ T6033] cached 0 [ 147.640770][ T6033] reserved 0 [ 147.640782][ T6033] online_reserved 0 [ 147.640795][ T6033] nr_inodes 0 [ 147.640808][ T6033] [ 147.640819][ T6033] freelist_wait waiting [ 147.640832][ T6033] open buckets allocated1 [ 147.640844][ T6033] open buckets total 1024 [ 147.640857][ T6033] open_buckets_wait empty [ 147.640870][ T6033] open_buckets_btree 0 [ 147.640882][ T6033] open_buckets_user 0 [ 147.640895][ T6033] btree reserve cache 0 [ 147.640907][ T6033] [ 147.640918][ T6033] Dev 0: [ 147.640930][ T6033] buckets sectors fragmented [ 147.640945][ T6033] free 0 0 0 [ 147.640959][ T6033] sb 0 0 0 [ 147.640974][ T6033] journal 0 0 0 [ 147.640989][ T6033] btree 0 0 0 [ 147.641004][ T6033] user 0 0 0 [ 147.641018][ T6033] cached 0 0 0 [ 147.641033][ T6033] parity 0 0 0 [ 147.641048][ T6033] stripe 0 0 0 [ 147.641062][ T6033] need_gc_gens 0 0 0 [ 147.641077][ T6033] need_discard 0 0 0 [ 147.641092][ T6033] unstriped 0 0 0 [ 147.641107][ T6033] capacity 128 [ 147.641119][ T6033] [ 147.641130][ T6033] reserves: [ 147.641142][ T6033] stripe 60 [ 147.641155][ T6033] normal 58 [ 147.641167][ T6033] copygc 56 [ 147.641180][ T6033] btree 28 [ 147.641193][ T6033] btree_copygc 0 [ 147.641206][ T6033] reclaim 0 [ 147.641218][ T6033] interior_updates 0 [ 147.641231][ T6033] [ 147.641242][ T6033] open buckets 0 [ 147.641255][ T6033] buckets to invalidate 0 [ 147.641268][ T6033] [ 147.641279][ T6033] Copygc debug: [ 147.641291][ T6033] running: 1 [ 147.641303][ T6033] copygc_wait:0 [ 147.641315][ T6033] copygc_wait_at:0 [ 147.641332][ T6033] Currently waiting for:0 B [ 147.641345][ T6033] Currently waiting since:640 KiB [ 147.641359][ T6033] Currently calculated wait:0 B [ 147.641371][ T6033] [ 147.641383][ T6033] Journal debug: [ 147.641394][ T6033] flags: running,may_skip_flush [ 147.641409][ T6033] dirty journal entries: 0/32768 [ 147.641422][ T6033] seq: 8 [ 147.641435][ T6033] seq_ondisk: 8 [ 147.641448][ T6033] last_seq: 9 [ 147.641460][ T6033] last_seq_ondisk: 8 [ 147.641474][ T6033] flushed_seq_ondisk: 8 [ 147.641487][ T6033] watermark: stripe [ 147.641500][ T6033] each entry reserved: 321 [ 147.641513][ T6033] nr flush writes: 1 [ 147.641526][ T6033] nr noflush writes: 0 [ 147.641538][ T6033] average write size: 1.23 KiB [ 147.641552][ T6033] nr direct reclaim: 0 [ 147.641564][ T6033] nr background reclaim: 0 [ 147.641577][ T6033] reclaim kicked: 0 [ 147.641590][ T6033] reclaim runs in: 0 ms [ 147.641603][ T6033] blocked: 0 [ 147.641615][ T6033] current entry sectors: 256 [ 147.641628][ T6033] current entry error: ok [ 147.641641][ T6033] current entry: closed [ 147.641654][ T6033] unwritten entries: [ 147.641666][ T6033] last buf closed [ 147.641678][ T6033] space: [ 147.641690][ T6033] discarded 256:1536 [ 147.641703][ T6033] clean ondisk 256:1536 [ 147.641716][ T6033] clean 256:1536 [ 147.641729][ T6033] total 256:2048 [ 147.641743][ T6033] dev 0: [ 147.641754][ T6033] nr 8 [ 147.641767][ T6033] bucket size 256 [ 147.641780][ T6033] available 6:248 [ 147.641793][ T6033] discard_idx 0 [ 147.641805][ T6033] dirty_ondisk 0 (seq 8) [ 147.641818][ T6033] dirty_idx 0 (seq 8) [ 147.641832][ T6033] cur_idx 0 (seq 8) [ 147.641845][ T6033] 2024/10/18 18:42:12 executed programs: 68 2024/10/18 18:42:17 executed programs: 85 2024/10/18 18:42:23 executed programs: 102 2024/10/18 18:42:28 executed programs: 119 2024/10/18 18:42:33 executed programs: 136 2024/10/18 18:42:38 executed programs: 153 2024/10/18 18:42:43 executed programs: 170 2024/10/18 18:42:48 executed programs: 187 2024/10/18 18:42:53 executed programs: 204 [ 193.713248][ T1254] ieee802154 phy0 wpan0: encryption failed: -22 [ 193.722830][ T1254] ieee802154 phy1 wpan1: encryption failed: -22 2024/10/18 18:42:58 executed programs: 221 2024/10/18 18:43:03 executed programs: 238 2024/10/18 18:43:08 executed programs: 255 2024/10/18 18:43:13 executed programs: 272 2024/10/18 18:43:18 executed programs: 289 2024/10/18 18:43:23 executed programs: 306 2024/10/18 18:43:28 executed programs: 323 2024/10/18 18:43:33 executed programs: 340 2024/10/18 18:43:38 executed programs: 357 [ 236.753533][ T4619] Bluetooth: hci0: command 0x0406 tx timeout 2024/10/18 18:43:43 executed programs: 374 2024/10/18 18:43:48 executed programs: 391 2024/10/18 18:43:53 executed programs: 408 [ 252.113530][ T55] Bluetooth: hci1: command 0x0406 tx timeout [ 255.161036][ T1254] ieee802154 phy0 wpan0: encryption failed: -22 [ 255.169715][ T1254] ieee802154 phy1 wpan1: encryption failed: -22 2024/10/18 18:43:58 executed programs: 425 2024/10/18 18:44:04 executed programs: 442 2024/10/18 18:44:09 executed programs: 459 [ 267.310556][ T30] INFO: task syz-executor:5875 blocked for more than 143 seconds. [ 267.318647][ T30] Not tainted 6.12.0-rc3-syzkaller-g5e9ab267bec1 #0 [ 267.327778][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 267.336880][ T30] task:syz-executor state:D stack:20448 pid:5875 tgid:5875 ppid:1 flags:0x00004006 [ 267.347625][ T30] Call Trace: [ 267.351247][ T30] [ 267.354207][ T30] __schedule+0x1895/0x4b30 [ 267.358869][ T30] ? __pfx___schedule+0x10/0x10 [ 267.364311][ T30] ? __pfx_lock_release+0x10/0x10 [ 267.369508][ T30] ? schedule+0x90/0x320 [ 267.374254][ T30] schedule+0x14b/0x320 [ 267.378549][ T30] schedule_timeout+0xb0/0x310 [ 267.383760][ T30] ? __pfx_schedule_timeout+0x10/0x10 [ 267.389259][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 267.396242][ T30] ? wait_for_completion+0x2fe/0x620 [ 267.401832][ T30] ? wait_for_completion+0x2fe/0x620 [ 267.407228][ T30] ? _raw_spin_unlock_irq+0x23/0x50 [ 267.412941][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.418701][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 267.424242][ T30] ? wait_for_completion+0x2fe/0x620 [ 267.430172][ T30] wait_for_completion+0x355/0x620 [ 267.435318][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.441542][ T30] ? __pfx_wait_for_completion+0x10/0x10 [ 267.447255][ T30] ? synchronize_rcu+0x11b/0x360 [ 267.452842][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.458715][ T30] ? kthread_unpark+0xd0/0x290 [ 267.464425][ T30] kthread_stop+0x19e/0x640 [ 267.469015][ T30] bch2_copygc_stop+0x4f/0x150 [ 267.474732][ T30] __bch2_fs_read_only+0x47/0x430 [ 267.480174][ T30] bch2_fs_read_only+0xb57/0x1200 [ 267.485348][ T30] ? __pfx_bch2_fs_read_only+0x10/0x10 [ 267.491294][ T30] ? __bch2_print+0x17a/0x220 [ 267.496130][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.502225][ T30] ? down_write+0x18c/0x220 [ 267.506851][ T30] ? __pfx_down_write+0x10/0x10 [ 267.512197][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.517967][ T30] ? hook_sb_delete+0xaa0/0xbd0 [ 267.525359][ T30] __bch2_fs_stop+0x105/0x5c0 [ 267.530544][ T30] ? __pfx___bch2_fs_stop+0x10/0x10 [ 267.535851][ T30] ? __pfx_evict_inodes+0x10/0x10 [ 267.543622][ T30] ? bch2_sync_fs+0x155/0x300 [ 267.548341][ T30] ? __pfx_bch2_put_super+0x10/0x10 [ 267.554097][ T30] generic_shutdown_super+0x13b/0x2d0 [ 267.559519][ T30] bch2_kill_sb+0x41/0x50 [ 267.567267][ T30] deactivate_locked_super+0xc6/0x130 [ 267.573582][ T30] cleanup_mnt+0x41f/0x4b0 [ 267.578122][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.584960][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 267.590569][ T30] task_work_run+0x251/0x310 [ 267.595204][ T30] ? __pfx_task_work_run+0x10/0x10 [ 267.600847][ T30] ? __x64_sys_umount+0x123/0x170 [ 267.605911][ T30] ? syscall_exit_to_user_mode+0xa3/0x370 [ 267.612195][ T30] syscall_exit_to_user_mode+0x168/0x370 [ 267.617867][ T30] do_syscall_64+0x100/0x230 [ 267.622926][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 267.628868][ T30] RIP: 0033:0x7f438bb7f227 [ 267.634854][ T30] RSP: 002b:00007fffedabb5b8 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 [ 267.646558][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f438bb7f227 [ 267.655971][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fffedabb670 [ 267.665405][ T30] RBP: 00007fffedabb670 R08: 0000000000000000 R09: 0000000000000000 [ 267.674914][ T30] R10: 00000000ffffffff R11: 0000000000000246 R12: 00007fffedabc6f0 [ 267.684422][ T30] R13: 00007f438bbf0a14 R14: 000000000001c7d0 R15: 00007fffedabc730 [ 267.693565][ T30] [ 267.696672][ T30] [ 267.696672][ T30] Showing all locks held in the system: [ 267.705604][ T30] 1 lock held by khungtaskd/30: [ 267.711269][ T30] #0: ffffffff8e937e20 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0 [ 267.721821][ T30] 2 locks held by kworker/u8:4/62: [ 267.726958][ T30] #0: ffff8880b863ea98 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 [ 267.737559][ T30] #1: ffffe8ffffc1c188 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x17c/0x7a0 [ 267.749424][ T30] 2 locks held by getty/4984: [ 267.755585][ T30] #0: ffff88814b3a40a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 267.765732][ T30] #1: ffffc90002f062f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6a6/0x1e00 [ 267.776613][ T30] 2 locks held by syz-executor/5875: [ 267.782182][ T30] #0: ffff88802c0320e0 (&type->s_umount_key#52){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 267.792775][ T30] #1: ffff888066c00278 (&c->state_lock){+.+.}-{3:3}, at: __bch2_fs_stop+0xfd/0x5c0 [ 267.803635][ T30] [ 267.805982][ T30] ============================================= [ 267.805982][ T30] [ 267.814853][ T30] NMI backtrace for cpu 1 [ 267.819201][ T30] CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.12.0-rc3-syzkaller-g5e9ab267bec1 #0 [ 267.829201][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 267.839276][ T30] Call Trace: [ 267.842573][ T30] [ 267.845517][ T30] dump_stack_lvl+0x241/0x360 [ 267.850228][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 267.855451][ T30] ? __pfx__printk+0x10/0x10 [ 267.860078][ T30] nmi_cpu_backtrace+0x49c/0x4d0 [ 267.865051][ T30] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 267.870538][ T30] ? _printk+0xd5/0x120 [ 267.874713][ T30] ? __pfx__printk+0x10/0x10 [ 267.879504][ T30] ? __wake_up_klogd+0xcc/0x110 [ 267.884398][ T30] ? __pfx__printk+0x10/0x10 [ 267.889096][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.894758][ T30] ? __rcu_read_unlock+0xa1/0x110 [ 267.899822][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 267.905842][ T30] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 267.911855][ T30] watchdog+0xff4/0x1040 [ 267.916130][ T30] ? watchdog+0x1ea/0x1040 [ 267.920585][ T30] ? __pfx_watchdog+0x10/0x10 [ 267.925298][ T30] kthread+0x2f2/0x390 [ 267.929397][ T30] ? __pfx_watchdog+0x10/0x10 [ 267.934282][ T30] ? __pfx_kthread+0x10/0x10 [ 267.938901][ T30] ret_from_fork+0x4d/0x80 [ 267.943353][ T30] ? __pfx_kthread+0x10/0x10 [ 267.947973][ T30] ret_from_fork_asm+0x1a/0x30 [ 267.952788][ T30] [ 267.956086][ T30] Sending NMI from CPU 1 to CPUs 0: [ 267.961376][ C0] NMI backtrace for cpu 0 [ 267.961390][ C0] CPU: 0 UID: 0 PID: 967 Comm: kworker/u8:5 Not tainted 6.12.0-rc3-syzkaller-g5e9ab267bec1 #0 [ 267.961414][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 267.961428][ C0] Workqueue: events_unbound nsim_dev_trap_report_work [ 267.961461][ C0] RIP: 0010:unwind_next_frame+0x315/0x22d0 [ 267.961486][ C0] Code: 64 48 01 d2 48 01 f2 0f 84 42 01 00 00 48 8d 5a 04 4c 8d 72 05 48 89 d8 48 c1 e8 03 48 bd 00 00 00 00 00 fc ff df 0f b6 04 28 <84> c0 0f 85 58 18 00 00 4c 89 f0 48 c1 e8 03 0f b6 04 28 84 c0 0f [ 267.961503][ C0] RSP: 0018:ffffc90003a67510 EFLAGS: 00000217 [ 267.961522][ C0] RAX: 0000000000000000 RBX: ffffffff90a4538c RCX: ffffffff902e7d90 [ 267.961538][ C0] RDX: ffffffff90a45388 RSI: ffffffff90a45388 RDI: 0000000000000001 [ 267.961554][ C0] RBP: dffffc0000000000 R08: 0000000000000001 R09: ffffc90003a676d0 [ 267.961569][ C0] R10: dffffc0000000000 R11: ffffffff8180a0e0 R12: 0000000000000000 [ 267.961585][ C0] R13: ffffc90003a675e0 R14: ffffffff90a4538d R15: ffffffff815ea6d4 [ 267.961604][ C0] FS: 0000000000000000(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000 [ 267.961623][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 267.961643][ C0] CR2: 00007fca11dff000 CR3: 000000000e734000 CR4: 0000000000350ef0 [ 267.961662][ C0] Call Trace: [ 267.961670][ C0] [ 267.961678][ C0] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 267.961709][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 267.961746][ C0] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 267.961775][ C0] ? nmi_handle+0x2a/0x5a0 [ 267.961809][ C0] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 267.961840][ C0] ? nmi_handle+0x151/0x5a0 [ 267.961864][ C0] ? nmi_handle+0x2a/0x5a0 [ 267.961888][ C0] ? unwind_next_frame+0x315/0x22d0 [ 267.961909][ C0] ? default_do_nmi+0x63/0x160 [ 267.961940][ C0] ? exc_nmi+0x123/0x1f0 [ 267.961969][ C0] ? end_repeat_nmi+0xf/0x53 [ 267.961992][ C0] ? process_scheduled_works+0xa64/0x1850 [ 267.962026][ C0] ? __pfx_stack_trace_consume_entry+0x10/0x10 [ 267.962059][ C0] ? unwind_next_frame+0x315/0x22d0 [ 267.962081][ C0] ? unwind_next_frame+0x315/0x22d0 [ 267.962104][ C0] ? unwind_next_frame+0x315/0x22d0 [ 267.962126][ C0] [ 267.962133][ C0] [ 267.962147][ C0] ? process_scheduled_works+0xa65/0x1850 [ 267.962181][ C0] ? __pfx_stack_trace_consume_entry+0x10/0x10 [ 267.962209][ C0] arch_stack_walk+0x11c/0x150 [ 267.962237][ C0] ? process_scheduled_works+0xa65/0x1850 [ 267.962272][ C0] stack_trace_save+0x118/0x1d0 [ 267.962298][ C0] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.962326][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 267.962357][ C0] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.962382][ C0] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 267.962420][ C0] kasan_save_track+0x3f/0x80 [ 267.962443][ C0] ? kasan_save_track+0x3f/0x80 [ 267.962464][ C0] ? kasan_save_free_info+0x40/0x50 [ 267.962496][ C0] ? __kasan_slab_free+0x59/0x70 [ 267.962519][ C0] ? kfree+0x1a0/0x440 [ 267.962545][ C0] ? skb_release_data+0x6a0/0x8a0 [ 267.962571][ C0] ? consume_skb+0x9f/0xf0 [ 267.962592][ C0] ? nsim_dev_trap_report_work+0x765/0xab0 [ 267.962619][ C0] ? process_scheduled_works+0xa65/0x1850 [ 267.962683][ C0] kasan_save_free_info+0x40/0x50 [ 267.962715][ C0] __kasan_slab_free+0x59/0x70 [ 267.962739][ C0] ? skb_release_data+0x6a0/0x8a0 [ 267.962764][ C0] kfree+0x1a0/0x440 [ 267.962791][ C0] ? __local_bh_enable_ip+0x168/0x200 [ 267.962821][ C0] ? skb_release_data+0x6a0/0x8a0 [ 267.962849][ C0] skb_release_data+0x6a0/0x8a0 [ 267.962881][ C0] consume_skb+0x9f/0xf0 [ 267.962904][ C0] nsim_dev_trap_report_work+0x765/0xab0 [ 267.962941][ C0] ? process_scheduled_works+0x976/0x1850 [ 267.962973][ C0] process_scheduled_works+0xa65/0x1850 [ 267.963022][ C0] ? __pfx_process_scheduled_works+0x10/0x10 [ 267.963059][ C0] ? assign_work+0x364/0x3d0 [ 267.963093][ C0] worker_thread+0x870/0xd30 [ 267.963127][ C0] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.963155][ C0] ? srso_alias_return_thunk+0x5/0xfbef5 [ 267.963180][ C0] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 267.963219][ C0] ? __kthread_parkme+0x169/0x1d0 [ 267.963254][ C0] ? __pfx_worker_thread+0x10/0x10 [ 267.963287][ C0] kthread+0x2f2/0x390 [ 267.963308][ C0] ? __pfx_worker_thread+0x10/0x10 [ 267.963340][ C0] ? __pfx_kthread+0x10/0x10 [ 267.963363][ C0] ret_from_fork+0x4d/0x80 [ 267.963396][ C0] ? __pfx_kthread+0x10/0x10 [ 267.963418][ C0] ret_from_fork_asm+0x1a/0x30 [ 267.963460][ C0] [ 267.965309][ T30] Kernel panic - not syncing: hung_task: blocked tasks [ 268.412437][ T30] CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.12.0-rc3-syzkaller-g5e9ab267bec1 #0 [ 268.422512][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 268.432569][ T30] Call Trace: [ 268.435850][ T30] [ 268.438815][ T30] dump_stack_lvl+0x241/0x360 [ 268.443521][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 268.448731][ T30] ? __pfx__printk+0x10/0x10 [ 268.453325][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 268.459331][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 268.465063][ T30] ? vscnprintf+0x5d/0x90 [ 268.469411][ T30] panic+0x349/0x880 [ 268.473346][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 268.478994][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 268.485160][ T30] ? __pfx_panic+0x10/0x10 [ 268.489580][ T30] ? tick_nohz_tick_stopped+0x82/0xb0 [ 268.495405][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 268.501045][ T30] ? __irq_work_queue_local+0x137/0x410 [ 268.506605][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 268.512251][ T30] ? preempt_schedule_thunk+0x1a/0x30 [ 268.517650][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 268.523817][ T30] ? nmi_trigger_cpumask_backtrace+0x2d4/0x320 [ 268.529995][ T30] ? srso_alias_return_thunk+0x5/0xfbef5 [ 268.535649][ T30] ? nmi_trigger_cpumask_backtrace+0x2d9/0x320 [ 268.541822][ T30] watchdog+0x1033/0x1040 [ 268.546180][ T30] ? watchdog+0x1ea/0x1040 [ 268.550618][ T30] ? __pfx_watchdog+0x10/0x10 [ 268.555308][ T30] kthread+0x2f2/0x390 [ 268.559381][ T30] ? __pfx_watchdog+0x10/0x10 [ 268.564078][ T30] ? __pfx_kthread+0x10/0x10 [ 268.568671][ T30] ret_from_fork+0x4d/0x80 [ 268.573106][ T30] ? __pfx_kthread+0x10/0x10 [ 268.577790][ T30] ret_from_fork_asm+0x1a/0x30 [ 268.582581][ T30] [ 268.585922][ T30] Kernel Offset: disabled [ 268.590245][ T30] Rebooting in 86400 seconds..