Warning: Permanently added '10.128.0.198' (ED25519) to the list of known hosts. 2026/09/25 22:45:58 parsed 1 programs 2026/09/25 22:45:58 serving rpc on tcp://38981 [ 80.568443][ T4283] cgroup: Unknown subsys name 'net' [ 80.705716][ T4283] cgroup: Unknown subsys name 'rlimit' Setting up swapspace version 1, size = 127995904 bytes [ 82.260131][ T4283] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k FS [ 85.408052][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 85.418786][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 85.429267][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 85.452892][ T11] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 85.461032][ T11] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 85.468733][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 86.048107][ T4350] chnl_net:caif_netlink_parms(): no params data found [ 86.104192][ T4350] bridge0: port 1(bridge_slave_0) entered blocking state [ 86.113674][ T4350] bridge0: port 1(bridge_slave_0) entered disabled state [ 86.121867][ T4350] device bridge_slave_0 entered promiscuous mode [ 86.131992][ T4350] bridge0: port 2(bridge_slave_1) entered blocking state [ 86.139275][ T4350] bridge0: port 2(bridge_slave_1) entered disabled state [ 86.147441][ T4350] device bridge_slave_1 entered promiscuous mode [ 86.173543][ T4350] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 86.184657][ T4350] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 86.206385][ T4350] team0: Port device team_slave_0 added [ 86.223348][ T4350] team0: Port device team_slave_1 added [ 86.242476][ T4350] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 86.249446][ T4350] 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. [ 86.275939][ T4350] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 86.296284][ T4350] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 86.303310][ T4350] 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. [ 86.329965][ T4350] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 86.365227][ T4350] device hsr_slave_0 entered promiscuous mode [ 86.372799][ T4350] device hsr_slave_1 entered promiscuous mode [ 86.473808][ T4350] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 86.516660][ T4350] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 86.526674][ T4350] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 86.535689][ T4350] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 86.631866][ T4350] 8021q: adding VLAN 0 to HW filter on device bond0 [ 86.643803][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 86.652950][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 86.678945][ T4350] 8021q: adding VLAN 0 to HW filter on device team0 [ 86.696915][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 86.706239][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 86.716496][ T57] bridge0: port 1(bridge_slave_0) entered blocking state [ 86.723794][ T57] bridge0: port 1(bridge_slave_0) entered forwarding state [ 86.736166][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 86.751459][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 86.766517][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 86.775824][ T9] bridge0: port 2(bridge_slave_1) entered blocking state [ 86.783023][ T9] bridge0: port 2(bridge_slave_1) entered forwarding state [ 86.801655][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 86.811362][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 86.821797][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 86.831251][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 86.839714][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 86.849385][ T41] cfg80211: failed to load regulatory.db [ 86.867933][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 86.891359][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 86.913204][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 86.922507][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 86.938157][ T4350] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 86.950860][ T4350] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 86.958926][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 86.969429][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 87.327698][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 87.336566][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 87.355043][ T4350] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 87.376840][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 87.385972][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 87.414391][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 87.424447][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 87.438046][ T4350] device veth0_vlan entered promiscuous mode [ 87.445688][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 87.455843][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 87.476224][ T4350] device veth1_vlan entered promiscuous mode [ 87.501464][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 87.511948][ T57] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 87.528830][ T4350] device veth0_macvtap entered promiscuous mode [ 87.538440][ T4350] device veth1_macvtap entered promiscuous mode [ 87.554265][ T4350] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 87.563349][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 87.572321][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 87.580762][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 87.590248][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 87.609536][ T4350] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 87.617982][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 87.627454][ T47] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 87.639456][ T4350] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 87.648522][ T4350] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 87.658052][ T4350] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 87.667038][ T4350] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 88.224456][ T40] netdevsim netdevsim0 netdevsim3 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 88.411488][ T4373] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 88.420051][ T4373] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 88.428000][ T4373] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 88.436187][ T4373] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 88.444840][ T4373] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 88.454284][ T4373] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 2026/09/25 22:46:08 executed programs: 0 [ 88.971006][ T49] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 88.979332][ T49] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 88.988018][ T49] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 88.997115][ T49] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 89.006106][ T49] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 89.013428][ T49] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 89.131083][ T4382] chnl_net:caif_netlink_parms(): no params data found [ 89.177329][ T4382] bridge0: port 1(bridge_slave_0) entered blocking state [ 89.184693][ T4382] bridge0: port 1(bridge_slave_0) entered disabled state [ 89.192658][ T4382] device bridge_slave_0 entered promiscuous mode [ 89.201924][ T4382] bridge0: port 2(bridge_slave_1) entered blocking state [ 89.209223][ T4382] bridge0: port 2(bridge_slave_1) entered disabled state [ 89.217149][ T4382] device bridge_slave_1 entered promiscuous mode [ 89.237049][ T4382] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 89.248110][ T4382] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 89.275536][ T4382] team0: Port device team_slave_0 added [ 89.283258][ T4382] team0: Port device team_slave_1 added [ 89.300568][ T4382] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 89.307635][ T4382] 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. [ 89.334427][ T4382] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 89.348148][ T4382] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 89.355283][ T4382] 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. [ 89.381721][ T4382] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 89.415600][ T4382] device hsr_slave_0 entered promiscuous mode [ 89.422655][ T4382] device hsr_slave_1 entered promiscuous mode [ 89.429526][ T4382] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 89.437733][ T4382] Cannot create hsr debugfs directory [ 90.040881][ T40] netdevsim netdevsim0 netdevsim2 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 91.080713][ T4373] Bluetooth: hci0: command 0x0409 tx timeout [ 92.319334][ T40] netdevsim netdevsim0 netdevsim1 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 92.378391][ T40] netdevsim netdevsim0 netdevsim0 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0 [ 93.169955][ T4373] Bluetooth: hci0: command 0x041b tx timeout [ 93.187145][ T40] device hsr_slave_0 left promiscuous mode [ 93.194379][ T40] device hsr_slave_1 left promiscuous mode [ 93.211681][ T40] batman_adv: batadv0: Interface deactivated: batadv_slave_0 [ 93.219224][ T40] batman_adv: batadv0: Removing interface: batadv_slave_0 [ 93.236974][ T40] batman_adv: batadv0: Interface deactivated: batadv_slave_1 [ 93.245686][ T40] batman_adv: batadv0: Removing interface: batadv_slave_1 [ 93.254361][ T40] device bridge_slave_1 left promiscuous mode [ 93.265116][ T40] bridge0: port 2(bridge_slave_1) entered disabled state [ 93.277130][ T40] device bridge_slave_0 left promiscuous mode [ 93.287537][ T40] bridge0: port 1(bridge_slave_0) entered disabled state [ 93.317585][ T40] device veth1_macvtap left promiscuous mode [ 93.327589][ T40] device veth0_macvtap left promiscuous mode [ 93.333931][ T40] device veth1_vlan left promiscuous mode [ 93.342633][ T40] device veth0_vlan left promiscuous mode [ 93.751763][ T40] team0 (unregistering): Port device team_slave_1 removed [ 93.783338][ T40] team0 (unregistering): Port device team_slave_0 removed [ 93.811615][ T40] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 93.844155][ T40] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 94.041854][ T40] bond0 (unregistering): Released all slaves [ 94.148781][ T4382] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 94.157980][ T4382] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 94.170369][ T4382] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 94.179672][ T4382] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 94.245484][ T4382] 8021q: adding VLAN 0 to HW filter on device bond0 [ 94.257231][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 94.268177][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 94.294616][ T4382] 8021q: adding VLAN 0 to HW filter on device team0 [ 94.304850][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 94.313948][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 94.322664][ T9] bridge0: port 1(bridge_slave_0) entered blocking state [ 94.330384][ T9] bridge0: port 1(bridge_slave_0) entered forwarding state [ 94.338445][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 94.357844][ T4419] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 94.368154][ T4419] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 94.377369][ T4419] bridge0: port 2(bridge_slave_1) entered blocking state [ 94.384698][ T4419] bridge0: port 2(bridge_slave_1) entered forwarding state [ 94.396322][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 94.408673][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 94.427299][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 94.438487][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 94.447763][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 94.476613][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 94.485910][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 94.498038][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 94.506973][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 94.524914][ T4382] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 94.538685][ T4382] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 94.548246][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 94.558100][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 94.767333][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 94.775148][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 94.787219][ T4382] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 94.804955][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 94.814380][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 94.833472][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 94.842580][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 94.851984][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 94.859709][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 94.877370][ T4382] device veth0_vlan entered promiscuous mode [ 94.887768][ T4382] device veth1_vlan entered promiscuous mode [ 94.906653][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 94.915764][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 94.924066][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 94.933585][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 94.953594][ T4382] device veth0_macvtap entered promiscuous mode [ 94.963721][ T4382] device veth1_macvtap entered promiscuous mode [ 94.978057][ T4382] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 94.986871][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 94.996274][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 95.005133][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 95.014519][ T9] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 95.033781][ T4382] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 95.042729][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 95.051641][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 95.064296][ T4382] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.073247][ T4382] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.082513][ T4382] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.092158][ T4382] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.161789][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 95.174775][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 95.184755][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 95.213291][ T11] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 95.221260][ T11] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 95.228780][ T11] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 95.240812][ T4373] Bluetooth: hci0: command 0x040f tx timeout [ 95.572509][ T4341] usb 1-1: new high-speed USB device number 2 using dummy_hcd [ 95.772439][ T4341] usb 1-1: config 1 interface 0 altsetting 0 endpoint 0x4 has invalid wMaxPacketSize 0 [ 95.782335][ T4341] usb 1-1: config 1 interface 0 altsetting 0 bulk endpoint 0x4 has invalid maxpacket 0 [ 95.792127][ T4341] usb 1-1: New USB device found, idVendor=0424, idProduct=012c, bcdDevice= 0.00 [ 95.802405][ T4341] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 95.822258][ T4341] usb 1-1: probing VID:PID(0424:012C) [ 95.831594][ T4341] usb 1-1: vub300 testing BULK IN EndPoint(0) 81 [ 95.838415][ T4341] usb 1-1: vub300 testing BULK OUT EndPoint(1) 02 [ 95.844924][ T4341] usb 1-1: vub300 testing BULK IN EndPoint(2) 83 [ 95.851698][ T4341] usb 1-1: vub300 testing BULK OUT EndPoint(3) 04 [ 95.858145][ T4341] usb 1-1: vub300 LARGE packets using EndPoints 02 81 04 83 [ 96.219873][ T4341] usb 1-1: operating_mode = IRQs 4-bit 48 MHz with 512 byte USB packets [ 96.420400][ T4341] usb 1-1: USB vub300 remote SDIO host controller[0]connected with SD/SDIO card inserted [ 97.253626][ T4341] usb 1-1: SET_CLOCK_SPEED 200kHz failed with retval=-71 [ 97.281582][ T4341] usb 1-1: USB disconnect, device number 2 [ 97.298481][ T4341] USB vub300 remote SDIO host controller[0] now disconnected [ 97.480134][ C0] [ 97.489944][ C0] ================================ [ 97.495098][ C0] WARNING: inconsistent lock state [ 97.500226][ C0] syzkaller #0 Not tainted [ 97.504744][ C0] -------------------------------- [ 97.509958][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 97.516832][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 97.522874][ C0] ffff8880774ac648 ((work_completion)(&(&host->detect)->work)){+.?.}-{0:0}, at: __flush_work+0x109/0xac0 [ 97.534239][ C0] {SOFTIRQ-ON-W} state was registered at: [ 97.539979][ C0] lock_acquire+0x1bb/0x4a0 [ 97.544713][ C0] __flush_work+0x122/0xac0 [ 97.549412][ C0] __cancel_work_timer+0x3f4/0x560 [ 97.554643][ C0] mmc_stop_host+0xd5/0x460 [ 97.559254][ C0] mmc_remove_host+0x11/0x60 [ 97.564042][ C0] vub300_disconnect+0x14b/0x2e0 [ 97.569094][ C0] usb_unbind_interface+0x200/0x870 [ 97.574407][ C0] device_release_driver_internal+0x4cf/0x7c0 [ 97.580600][ C0] bus_remove_device+0x2dd/0x400 [ 97.585682][ C0] device_del+0x63f/0xa80 [ 97.590131][ C0] usb_disable_device+0x3e7/0x8a0 [ 97.595442][ C0] usb_disconnect+0x33c/0x8a0 [ 97.600236][ C0] hub_event+0x1d27/0x5200 [ 97.604851][ C0] process_one_work+0x8ab/0x1160 [ 97.610086][ C0] worker_thread+0xd6e/0x12a0 [ 97.614861][ C0] kthread+0x29d/0x330 [ 97.619113][ C0] ret_from_fork+0x1f/0x30 [ 97.623611][ C0] irq event stamp: 341206 [ 97.627922][ C0] hardirqs last enabled at (341206): [] __cancel_work_timer+0x36a/0x560 [ 97.637987][ C0] hardirqs last disabled at (341205): [] try_to_grab_pending+0xfa/0x890 [ 97.647903][ C0] softirqs last enabled at (341126): [] __irq_exit_rcu+0x13b/0x230 [ 97.657462][ C0] softirqs last disabled at (341139): [] __irq_exit_rcu+0x13b/0x230 [ 97.667025][ C0] [ 97.667025][ C0] other info that might help us debug this: [ 97.675199][ C0] Possible unsafe locking scenario: [ 97.675199][ C0] [ 97.682679][ C0] CPU0 [ 97.686036][ C0] ---- [ 97.689309][ C0] lock((work_completion)(&(&host->detect)->work)); [ 97.695975][ C0] [ 97.699416][ C0] lock((work_completion)(&(&host->detect)->work)); [ 97.706268][ C0] [ 97.706268][ C0] *** DEADLOCK *** [ 97.706268][ C0] [ 97.714411][ C0] 1 lock held by swapper/0/0: [ 97.719073][ C0] #0: ffffc90000007bc0 ((&vub300->inactivity_timer)){+.-.}-{0:0}, at: call_timer_fn+0xcf/0x670 [ 97.729505][ C0] [ 97.729505][ C0] stack backtrace: [ 97.735388][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted syzkaller #0 [ 97.742407][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/16/2026 [ 97.752468][ C0] Call Trace: [ 97.755739][ C0] [ 97.758586][ C0] dump_stack_lvl+0x188/0x24e [ 97.763274][ C0] ? show_regs_print_info+0x12/0x12 [ 97.768466][ C0] valid_state+0x13b/0x1d0 [ 97.772879][ C0] mark_lock_irq+0xa9/0x900 [ 97.777375][ C0] ? stack_trace_save+0xa6/0xf0 [ 97.782249][ C0] ? save_trace+0xbb0/0xbb0 [ 97.786785][ C0] ? save_trace+0x5a/0xbb0 [ 97.791379][ C0] mark_lock+0x208/0x320 [ 97.795816][ C0] __lock_acquire+0xce0/0x7c40 [ 97.800682][ C0] ? __lock_acquire+0x7c40/0x7c40 [ 97.805709][ C0] ? verify_lock_unused+0x140/0x140 [ 97.810906][ C0] ? __lock_acquire+0x7c40/0x7c40 [ 97.815930][ C0] ? debug_object_assert_init+0x1ed/0x300 [ 97.821654][ C0] lock_acquire+0x1bb/0x4a0 [ 97.826255][ C0] ? __flush_work+0x109/0xac0 [ 97.830962][ C0] ? do_raw_spin_unlock+0x11d/0x230 [ 97.836162][ C0] ? read_lock_is_recursive+0x10/0x10 [ 97.841541][ C0] ? _raw_spin_unlock_irqrestore+0xc1/0x120 [ 97.847432][ C0] ? _raw_spin_unlock+0x40/0x40 [ 97.852279][ C0] ? slab_free_freelist_hook+0x133/0x1b0 [ 97.857928][ C0] ? kobject_put+0x25c/0x450 [ 97.862720][ C0] ? vub300_inactivity_timer_expired+0x190/0x3e0 [ 97.869074][ C0] ? call_timer_fn+0x1ac/0x670 [ 97.873838][ C0] ? __flush_work+0x109/0xac0 [ 97.878512][ C0] __flush_work+0x122/0xac0 [ 97.883005][ C0] ? __flush_work+0x109/0xac0 [ 97.887672][ C0] ? flush_work+0x20/0x20 [ 97.891993][ C0] ? __timer_delete+0x6c/0x220 [ 97.896769][ C0] ? mark_lock+0x94/0x320 [ 97.901100][ C0] ? lockdep_hardirqs_on_prepare+0x448/0x7c0 [ 97.907158][ C0] ? mod_delayed_work_on+0x1b0/0x1b0 [ 97.912435][ C0] ? lock_chain_count+0x20/0x20 [ 97.917278][ C0] ? kasan_quarantine_put+0xd4/0x210 [ 97.922556][ C0] ? __cancel_work_timer+0x36a/0x560 [ 97.927831][ C0] __cancel_work_timer+0x3f4/0x560 [ 97.932940][ C0] ? cancel_work_sync+0x20/0x20 [ 97.937974][ C0] ? kobject_put+0x25c/0x450 [ 97.942577][ C0] ? __kmem_cache_free+0xb6/0x200 [ 97.947624][ C0] ? kobject_put+0x41d/0x450 [ 97.952216][ C0] mmc_free_host+0x15/0x30 [ 97.956730][ C0] call_timer_fn+0x1ac/0x670 [ 97.961329][ C0] ? kref_get+0x70/0x70 [ 97.965484][ C0] ? call_timer_fn+0xcf/0x670 [ 97.970240][ C0] ? __run_timers+0x810/0x810 [ 97.974911][ C0] ? _raw_spin_unlock_irq+0x1f/0x40 [ 97.980108][ C0] ? lockdep_hardirqs_on+0x94/0x140 [ 97.985312][ C0] ? kref_get+0x70/0x70 [ 97.989468][ C0] __run_timers+0x56c/0x810 [ 97.993988][ C0] ? detach_timer+0x350/0x350 [ 97.998673][ C0] ? lock_chain_count+0x20/0x20 [ 98.003631][ C0] run_timer_softirq+0x63/0xf0 [ 98.008606][ C0] handle_softirqs+0x291/0x910 [ 98.013407][ C0] ? __irq_exit_rcu+0x13b/0x230 [ 98.018451][ C0] ? do_softirq+0x210/0x210 [ 98.022985][ C0] ? hrtimer_interrupt+0x775/0x980 [ 98.028116][ C0] ? irqtime_account_irq+0xb2/0x1b0 [ 98.033417][ C0] __irq_exit_rcu+0x13b/0x230 [ 98.038099][ C0] ? irq_exit_rcu+0x20/0x20 [ 98.042607][ C0] irq_exit_rcu+0x5/0x20 [ 98.046965][ C0] sysvec_apic_timer_interrupt+0xa0/0xc0 [ 98.052593][ C0] [ 98.055517][ C0] [ 98.058438][ C0] asm_sysvec_apic_timer_interrupt+0x16/0x20 [ 98.064411][ C0] RIP: 0010:default_idle+0xb/0x10 [ 98.069449][ C0] Code: 48 89 df e8 37 f3 96 f7 e9 44 ff ff ff e8 7d 03 f6 ff 00 00 cc cc 00 00 cc cc 00 00 cc cc 00 66 90 0f 00 2d 77 23 4a 00 fb f4 0f 1f 40 00 41 57 41 56 53 49 be 00 00 00 00 00 fc ff df 65 48 [ 98.089522][ C0] RSP: 0018:ffffffff8c807d88 EFLAGS: 000002c6 [ 98.095700][ C0] RAX: 166238c0e487d800 RBX: ffffffff8a3c8957 RCX: 166238c0e487d800 [ 98.103672][ C0] RDX: 0000000000000001 RSI: ffffffff8a8c18a0 RDI: ffffffff8adf68a0 [ 98.111652][ C0] RBP: ffffffff8c807ec0 R08: ffff8880b8e357cb R09: 1ffff110171c6af9 [ 98.119631][ C0] R10: dffffc0000000000 R11: ffffed10171c6afa R12: 0000000000000000 [ 98.127612][ C0] R13: dffffc0000000000 R14: ffffffff8c8bc740 R15: 1ffffffff1900fbc [ 98.135618][ C0] ? default_idle_call+0x77/0xc0 [ 98.140571][ C0] default_idle_call+0x84/0xc0 [ 98.145349][ C0] do_idle+0x3a2/0x680 [ 98.149420][ C0] ? idle_inject_timer_fn+0x60/0x60 [ 98.154629][ C0] ? schedule_idle+0x57/0x90 [ 98.159228][ C0] ? do_idle+0x669/0x680 [ 98.163484][ C0] cpu_startup_entry+0x3f/0x60 [ 98.168253][ C0] rest_init+0x2dc/0x300 [ 98.172514][ C0] ? time_init+0x33/0x33 [ 98.176860][ C0] arch_call_rest_init+0xa/0xa [ 98.181755][