[ 59.664584][ T11] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.686427][ T11] device veth1_macvtap left promiscuous mode [ 59.692747][ T11] device veth0_macvtap left promiscuous mode [ 59.699582][ T11] device veth1_vlan left promiscuous mode [ 59.705537][ T11] device veth0_vlan left promiscuous mode [ 59.841743][ T11] team0 (unregistering): Port device team_slave_1 removed [ 59.854601][ T11] team0 (unregistering): Port device team_slave_0 removed [ 59.870435][ T11] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 59.883947][ T11] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 59.931230][ T11] bond0 (unregistering): Released all slaves Warning: Permanently added '10.128.1.9' (ECDSA) to the list of known hosts. 2022/07/04 03:24:16 parsed 1 programs 2022/07/04 03:24:16 executed programs: 0 [ 74.959312][ T4056] cgroup: Unknown subsys name 'net' [ 74.968380][ T4056] cgroup: Unknown subsys name 'rlimit' [ 76.061300][ T47] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 76.069676][ T47] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 76.077480][ T47] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 76.085343][ T47] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 76.093832][ T47] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 76.101743][ T47] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 76.179816][ T4062] chnl_net:caif_netlink_parms(): no params data found [ 76.218955][ T4062] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.226273][ T4062] bridge0: port 1(bridge_slave_0) entered disabled state [ 76.234004][ T4062] device bridge_slave_0 entered promiscuous mode [ 76.242529][ T4062] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.249766][ T4062] bridge0: port 2(bridge_slave_1) entered disabled state [ 76.257824][ T4062] device bridge_slave_1 entered promiscuous mode [ 76.278785][ T4062] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 76.290374][ T4062] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 76.311729][ T26] cfg80211: failed to load regulatory.db [ 76.327753][ T4062] team0: Port device team_slave_0 added [ 76.337855][ T4062] team0: Port device team_slave_1 added [ 76.372316][ T4062] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 76.379575][ T4062] 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. [ 76.408541][ T4062] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 76.423214][ T4062] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 76.432230][ T4062] 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. [ 76.460682][ T4062] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 76.502683][ T4062] device hsr_slave_0 entered promiscuous mode [ 76.509787][ T4062] device hsr_slave_1 entered promiscuous mode [ 76.614951][ T4062] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.622598][ T4062] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.630616][ T4062] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.637796][ T4062] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.709079][ T4062] 8021q: adding VLAN 0 to HW filter on device bond0 [ 76.725069][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 76.737512][ T3619] bridge0: port 1(bridge_slave_0) entered disabled state [ 76.745512][ T3619] bridge0: port 2(bridge_slave_1) entered disabled state [ 76.756418][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 76.773722][ T4062] 8021q: adding VLAN 0 to HW filter on device team0 [ 76.790582][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 76.800484][ T3619] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.807744][ T3619] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.829039][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 76.837866][ T6] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.844939][ T6] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.853464][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 76.862636][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 76.878332][ T4062] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 76.889785][ T4062] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 76.902794][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 76.910677][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 76.919805][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 76.928881][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 76.946209][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 76.953787][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 76.965262][ T4062] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 77.157158][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 77.175856][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 77.184459][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 77.194866][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 77.202834][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 77.211622][ T4062] device veth0_vlan entered promiscuous mode [ 77.222865][ T4062] device veth1_vlan entered promiscuous mode [ 77.240490][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 77.248925][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 77.257493][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 77.266158][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 77.277213][ T4062] device veth0_macvtap entered promiscuous mode [ 77.288022][ T4062] device veth1_macvtap entered promiscuous mode [ 77.302426][ T4062] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 77.310709][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 77.319231][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 77.327692][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 77.336842][ T3619] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 77.349795][ T4062] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 77.357326][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 77.366177][ T3622] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 77.417228][ T8] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.425349][ T8] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.444262][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 77.454817][ T8] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.463286][ T8] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.472773][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 77.805919][ T22] usb 1-1: new high-speed USB device number 2 using dummy_hcd [ 78.137002][ T3622] Bluetooth: hci0: command 0x0409 tx timeout [ 78.236157][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 78.247419][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 78.257568][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 78.269484][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 78.280767][ T22] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 78.289882][ T22] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 78.302841][ T22] usb 1-1: config 0 descriptor?? [ 78.327293][ T4083] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 78.777530][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.795946][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.817067][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.836652][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.842770][ T22] input input5: Limiting number of effects to 32 (device reports 194) [ 78.865963][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.885943][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.905869][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.926109][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 78.935404][ T22] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input5 [ 78.954906][ T22] usb 1-1: USB disconnect, device number 2 [ 79.565836][ T22] usb 1-1: new high-speed USB device number 3 using dummy_hcd [ 79.925922][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 79.937996][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 79.948177][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 79.959622][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 79.971154][ T22] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 79.980582][ T22] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 79.994398][ T22] usb 1-1: config 0 descriptor?? [ 80.016837][ T4086] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 80.216423][ T26] Bluetooth: hci0: command 0x041b tx timeout [ 80.475894][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.496102][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.516159][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.536084][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.542211][ T22] input input6: Limiting number of effects to 32 (device reports 53) [ 80.565922][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.585925][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.605890][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.625890][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 80.641082][ T22] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input6 [ 80.662011][ T22] usb 1-1: USB disconnect, device number 3 2022/07/04 03:24:22 executed programs: 2 [ 81.245812][ T22] usb 1-1: new high-speed USB device number 4 using dummy_hcd [ 81.616167][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 81.627383][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 81.637384][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 81.648788][ T22] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 81.660149][ T22] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 81.669366][ T22] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 81.678958][ T22] usb 1-1: config 0 descriptor?? [ 81.696192][ T4088] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 82.145871][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.165900][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.185875][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.205892][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.212060][ T22] input input7: Limiting number of effects to 32 (device reports 57) [ 82.235892][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.255894][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.275845][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.296009][ T3622] Bluetooth: hci0: command 0x040f tx timeout [ 82.302944][ T22] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 82.310865][ T22] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input7 [ 82.328090][ T22] usb 1-1: USB disconnect, device number 4 [ 82.925907][ T3622] usb 1-1: new high-speed USB device number 5 using dummy_hcd [ 83.356072][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 83.367863][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 83.377858][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 83.389335][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 83.400669][ T3622] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 83.409752][ T3622] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 83.420095][ T3622] usb 1-1: config 0 descriptor?? [ 83.436154][ T4091] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 83.905839][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 83.935856][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 83.955849][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 83.975968][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 83.982070][ T3622] input input8: Limiting number of effects to 32 (device reports 98) [ 84.005794][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 84.025851][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 84.045860][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 84.065799][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 84.072546][ T3622] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input8 [ 84.088622][ T3622] usb 1-1: USB disconnect, device number 5 [ 84.375844][ T3622] Bluetooth: hci0: command 0x0419 tx timeout [ 84.665837][ T3622] usb 1-1: new high-speed USB device number 6 using dummy_hcd [ 85.065928][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 85.077929][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 85.088495][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 85.101461][ T3622] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 85.112830][ T3622] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 85.122166][ T3622] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 85.137648][ T3622] usb 1-1: config 0 descriptor?? [ 85.156190][ T4093] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 85.625901][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.646077][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.665899][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.685881][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.691970][ T3622] input input9: Limiting number of effects to 32 (device reports 89) [ 85.716649][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.736817][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.756628][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.776598][ T3622] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 85.784629][ T3622] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input9 [ 85.800417][ T3622] usb 1-1: USB disconnect, device number 6 2022/07/04 03:24:27 executed programs: 5 [ 86.405833][ T6] usb 1-1: new high-speed USB device number 7 using dummy_hcd [ 86.785943][ T6] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has an invalid bInterval 0, changing to 7 [ 86.797719][ T6] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0x81 has invalid wMaxPacketSize 0 [ 86.807523][ T6] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has an invalid bInterval 170, changing to 11 [ 86.819329][ T6] usb 1-1: config 0 interface 0 altsetting 0 endpoint 0xE has invalid maxpacket 25794, setting to 1024 [ 86.830551][ T6] usb 1-1: New USB device found, idVendor=06f8, idProduct=a302, bcdDevice=dc.46 [ 86.840419][ T6] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 86.850098][ T6] usb 1-1: config 0 descriptor?? [ 86.867076][ T4095] raw-gadget.0 gadget.0: fail, usb_ep_enable returned -22 [ 87.316297][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.336924][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.356603][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.385967][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.405892][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.436354][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.465866][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.495902][ T6] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 87.502709][ T6] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input10 [ 87.518606][ T6] usb 1-1: USB disconnect, device number 7 2022/07/04 03:24:35 executed programs: 8 2022/07/04 03:24:41 executed programs: 10 2022/07/04 03:24:47 executed programs: 12 2022/07/04 03:24:53 executed programs: 14 2022/07/04 03:24:59 executed programs: 16 2022/07/04 03:25:05 executed programs: 18 2022/07/04 03:25:11 executed programs: 20 [ 132.616792][ T1238] ieee802154 phy0 wpan0: encryption failed: -22 [ 132.623413][ T1238] ieee802154 phy1 wpan1: encryption failed: -22 2022/07/04 03:25:17 executed programs: 22 2022/07/04 03:25:23 executed programs: 24 2022/07/04 03:25:29 executed programs: 26 2022/07/04 03:25:35 executed programs: 28 2022/07/04 03:25:41 executed programs: 30 2022/07/04 03:25:47 executed programs: 32 2022/07/04 03:25:53 executed programs: 34 2022/07/04 03:25:59 executed programs: 36 2022/07/04 03:26:05 executed programs: 38 2022/07/04 03:26:11 executed programs: 40 [ 194.057703][ T1238] ieee802154 phy0 wpan0: encryption failed: -22 [ 194.064052][ T1238] ieee802154 phy1 wpan1: encryption failed: -22 2022/07/04 03:26:17 executed programs: 42 [ 201.255958][ T3622] Bluetooth: hci0: command 0x0406 tx timeout 2022/07/04 03:26:23 executed programs: 44 2022/07/04 03:26:30 executed programs: 46 2022/07/04 03:26:36 executed programs: 48 2022/07/04 03:26:42 executed programs: 50 2022/07/04 03:26:48 executed programs: 52 2022/07/04 03:26:54 executed programs: 54 [ 234.375942][ T28] INFO: task kworker/0:0:6 blocked for more than 143 seconds. [ 234.384003][ T28] Not tainted 5.19.0-rc4-syzkaller-00125-ga175eca0f3d7-dirty #0 [ 234.393059][ T28] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 234.402014][ T28] task:kworker/0:0 state:D stack:24472 pid: 6 ppid: 2 flags:0x00004000 [ 234.412334][ T28] Workqueue: usb_hub_wq hub_event [ 234.417995][ T28] Call Trace: [ 234.421432][ T28] [ 234.424401][ T28] __schedule+0xa00/0x4b50 [ 234.429324][ T28] ? find_held_lock+0x2d/0x110 [ 234.434182][ T28] ? wq_worker_sleeping+0x1e5/0x250 [ 234.439610][ T28] ? mark_held_locks+0x9f/0xe0 [ 234.444504][ T28] ? rwlock_bug.part.0+0x90/0x90 [ 234.449863][ T28] ? io_schedule_timeout+0x140/0x140 [ 234.455194][ T28] ? lockdep_hardirqs_on+0x79/0x100 [ 234.460710][ T28] schedule+0xd2/0x1f0 [ 234.464789][ T28] schedule_preempt_disabled+0xf/0x20 [ 234.470449][ T28] __mutex_lock+0xa70/0x1350 [ 234.475127][ T28] ? joydev_cleanup+0x21/0x190 [ 234.480278][ T28] ? mutex_lock_io_nested+0x1190/0x1190 [ 234.486255][ T28] ? reconfigure_single+0xd0/0xd0 [ 234.491331][ T28] ? slab_free_freelist_hook+0x8b/0x1c0 [ 234.497225][ T28] ? kfree+0xd6/0x4d0 [ 234.501232][ T28] ? kobj_unmap+0x232/0x2d0 [ 234.506237][ T28] joydev_cleanup+0x21/0x190 [ 234.510960][ T28] joydev_disconnect+0x45/0xb0 [ 234.516305][ T28] __input_unregister_device+0x1f1/0x460 [ 234.522269][ T28] input_unregister_device+0xb4/0xf0 [ 234.527795][ T28] iforce_usb_disconnect+0x5e/0xf0 [ 234.533097][ T28] usb_unbind_interface+0x1d8/0x8e0 [ 234.538508][ T28] ? usb_unbind_device+0x1a0/0x1a0 [ 234.543710][ T28] device_remove+0x11f/0x170 [ 234.548680][ T28] device_release_driver_internal+0x4a1/0x700 [ 234.554845][ T28] ? put_device+0x1b/0x30 [ 234.559350][ T28] bus_remove_device+0x2eb/0x5a0 [ 234.564531][ T28] device_del+0x4f3/0xc80 [ 234.569132][ T28] ? __device_link_del+0x380/0x380 [ 234.574348][ T28] ? kobject_put+0x1f3/0x540 [ 234.579133][ T28] usb_disable_device+0x35b/0x7b0 [ 234.584279][ T28] usb_disconnect.cold+0x278/0x6ec [ 234.589569][ T28] hub_event+0x1e83/0x4690 [ 234.594095][ T28] ? hub_port_debounce+0x3c0/0x3c0 [ 234.599481][ T28] ? lock_release+0x780/0x780 [ 234.604301][ T28] ? lock_downgrade+0x6e0/0x6e0 [ 234.609597][ T28] ? do_raw_spin_lock+0x120/0x2a0 [ 234.614701][ T28] process_one_work+0x996/0x1610 [ 234.620729][ T28] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 234.626678][ T28] ? rwlock_bug.part.0+0x90/0x90 [ 234.631753][ T28] ? _raw_spin_lock_irq+0x41/0x50 [ 234.636947][ T28] worker_thread+0x854/0x1080 [ 234.641716][ T28] ? process_one_work+0x1610/0x1610 [ 234.647036][ T28] kthread+0x2e9/0x3a0 [ 234.651133][ T28] ? kthread_complete_and_exit+0x40/0x40 [ 234.656836][ T28] ret_from_fork+0x1f/0x30 [ 234.661286][ T28] [ 234.664418][ T28] [ 234.664418][ T28] Showing all locks held in the system: [ 234.672203][ T28] 7 locks held by kworker/0:0/6: [ 234.677373][ T28] #0: ffff8881459c3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 234.688137][ T28] #1: ffffc900000b7da8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 234.699581][ T28] #2: ffff888147879190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4690 [ 234.708586][ T28] #3: ffff8880173a9190 (&dev->mutex){....}-{3:3}, at: usb_disconnect.cold+0x43/0x6ec [ 234.718659][ T28] #4: ffff8880173ae118 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa0/0x700 [ 234.729549][ T28] #5: ffffffff8ceafca8 (input_mutex){+.+.}-{3:3}, at: __input_unregister_device+0x158/0x460 [ 234.739870][ T28] #6: ffff88807bab4158 (&joydev->mutex){+.+.}-{3:3}, at: joydev_cleanup+0x21/0x190 [ 234.749357][ T28] 1 lock held by khungtaskd/28: [ 234.754286][ T28] #0: ffffffff8bd86660 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 [ 234.764263][ T28] 2 locks held by acpid/2960: [ 234.769012][ T28] #0: ffff88807bab4158 (&joydev->mutex){+.+.}-{3:3}, at: joydev_release+0x187/0x290 [ 234.778624][ T28] #1: ffff8880173af2c0 (&dev->mutex#2){+.+.}-{3:3}, at: input_close_device+0x42/0x1f0 [ 234.788480][ T28] 2 locks held by getty/3287: [ 234.793172][ T28] #0: ffff88802616e098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 [ 234.803134][ T28] #1: ffffc90002d162e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xe50/0x13c0 [ 234.813327][ T28] 2 locks held by udevd/4084: [ 234.818052][ T28] #0: ffff8881458fa110 (&evdev->mutex){+.+.}-{3:3}, at: evdev_open+0x2f3/0x6a0 [ 234.827500][ T28] #1: ffff8880173af2c0 (&dev->mutex#2){+.+.}-{3:3}, at: input_open_device+0x4a/0x320 [ 234.837818][ T28] [ 234.840332][ T28] ============================================= [ 234.840332][ T28] [ 234.849558][ T28] NMI backtrace for cpu 1 [ 234.853906][ T28] CPU: 1 PID: 28 Comm: khungtaskd Not tainted 5.19.0-rc4-syzkaller-00125-ga175eca0f3d7-dirty #0 [ 234.864416][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 234.874467][ T28] Call Trace: [ 234.877753][ T28] [ 234.880866][ T28] dump_stack_lvl+0xcd/0x134 [ 234.885591][ T28] nmi_cpu_backtrace.cold+0x47/0x144 [ 234.891000][ T28] ? lapic_can_unplug_cpu+0x80/0x80 [ 234.896299][ T28] nmi_trigger_cpumask_backtrace+0x1e6/0x230 [ 234.902463][ T28] watchdog+0xc1d/0xf50 [ 234.906628][ T28] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 234.912627][ T28] kthread+0x2e9/0x3a0 [ 234.916689][ T28] ? kthread_complete_and_exit+0x40/0x40 [ 234.922764][ T28] ret_from_fork+0x1f/0x30 [ 234.927183][ T28] [ 234.930309][ T28] Sending NMI from CPU 1 to CPUs 0: [ 234.935654][ C0] NMI backtrace for cpu 0 [ 234.935664][ C0] CPU: 0 PID: 41 Comm: kworker/u4:2 Not tainted 5.19.0-rc4-syzkaller-00125-ga175eca0f3d7-dirty #0 [ 234.935687][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 234.935698][ C0] Workqueue: phy5 ieee80211_iface_work [ 234.935797][ C0] RIP: 0010:___slab_alloc+0x74b/0xe20 [ 234.935822][ C0] Code: 8b 34 24 48 89 43 10 8b 05 5e 20 f5 0b 85 c0 0f 85 80 03 00 00 48 8b 43 10 80 78 2b 00 0f 89 25 04 00 00 8b 45 28 49 8b 04 06 <48> 83 43 08 08 48 89 03 48 8b 5d 00 e8 c4 bf b0 07 89 c5 48 83 c3 [ 234.935840][ C0] RSP: 0018:ffffc90000b27700 EFLAGS: 00000082 [ 234.935854][ C0] RAX: ffff888020bfa000 RBX: ffff8880b9a3db80 RCX: 0000000000000001 [ 234.935867][ C0] RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000000 [ 234.935877][ C0] RBP: ffff888011841dc0 R08: 0000000000000000 R09: 0000000080100010 [ 234.935890][ C0] R10: ffffffff81c69e72 R11: 0000000000000000 R12: 000000000003dba0 [ 234.935901][ C0] R13: 0000000000000246 R14: ffff888020bfb000 R15: 0000000000000000 [ 234.935913][ C0] FS: 0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000 [ 234.935932][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 234.935945][ C0] CR2: 00007f4fd6a83110 CR3: 000000000ba8e000 CR4: 00000000003506f0 [ 234.935957][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 234.935968][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 234.935980][ C0] Call Trace: [ 234.935985][ C0] [ 234.935993][ C0] ? ieee802_11_parse_elems_crc+0xd5/0x1050 [ 234.936046][ C0] ? ieee802_11_parse_elems_crc+0xd5/0x1050 [ 234.936065][ C0] __slab_alloc.constprop.0+0x4d/0xa0 [ 234.936090][ C0] kmem_cache_alloc_trace+0x310/0x3f0 [ 234.936113][ C0] ? ieee802_11_parse_elems_crc+0xd5/0x1050 [ 234.936134][ C0] ieee802_11_parse_elems_crc+0xd5/0x1050 [ 234.936155][ C0] ? cfg80211_inform_bss_frame_data+0xf2/0xb50 [ 234.936210][ C0] ? ieee80211_wake_vif_queues+0x40/0x40 [ 234.936229][ C0] ? cfg80211_inform_single_bss_frame_data+0xf40/0xf40 [ 234.936253][ C0] ? find_held_lock+0x2d/0x110 [ 234.936280][ C0] ieee80211_bss_info_update+0x42c/0xb00 [ 234.936331][ C0] ? ieee80211_rx_bss_put+0x50/0x50 [ 234.936353][ C0] ? ieee80211_ibss_rx_queued_mgmt+0x1a6a/0x33f0 [ 234.936384][ C0] ? ieee80211_mandatory_rates+0x1b4/0x240 [ 234.936440][ C0] ieee80211_ibss_rx_queued_mgmt+0x1ab8/0x33f0 [ 234.936468][ C0] ? ieee80211_ibss_rx_no_sta+0x840/0x840 [ 234.936489][ C0] ? kcov_remote_start+0x277/0x770 [ 234.936512][ C0] ? mark_held_locks+0x9f/0xe0 [ 234.936535][ C0] ? kcov_remote_start+0x155/0x770 [ 234.936555][ C0] ? kcov_remote_start+0x155/0x770 [ 234.936576][ C0] ? lockdep_hardirqs_on+0x79/0x100 [ 234.936597][ C0] ? _raw_spin_unlock_irqrestore+0x3d/0x70 [ 234.936621][ C0] ieee80211_iface_work+0xa78/0xd10 [ 234.936645][ C0] process_one_work+0x996/0x1610 [ 234.936669][ C0] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 234.936692][ C0] ? rwlock_bug.part.0+0x90/0x90 [ 234.936709][ C0] ? _raw_spin_lock_irq+0x41/0x50 [ 234.936732][ C0] worker_thread+0x665/0x1080 [ 234.936755][ C0] ? __kthread_parkme+0x15f/0x220 [ 234.936773][ C0] ? process_one_work+0x1610/0x1610 [ 234.936793][ C0] kthread+0x2e9/0x3a0 [ 234.936810][ C0] ? kthread_complete_and_exit+0x40/0x40 [ 234.936830][ C0] ret_from_fork+0x1f/0x30 [ 234.936857][ C0] [ 234.945386][ T28] Kernel panic - not syncing: hung_task: blocked tasks [ 234.945401][ T28] CPU: 1 PID: 28 Comm: khungtaskd Not tainted 5.19.0-rc4-syzkaller-00125-ga175eca0f3d7-dirty #0 [ 234.945427][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 234.945440][ T28] Call Trace: [ 234.945446][ T28] [ 234.945455][ T28] dump_stack_lvl+0xcd/0x134 [ 234.945486][ T28] panic+0x2d7/0x636 [ 234.945510][ T28] ? panic_print_sys_info.part.0+0x10b/0x10b [ 234.945541][ T28] ? lapic_can_unplug_cpu+0x80/0x80 [ 234.945568][ T28] ? preempt_schedule_thunk+0x16/0x18 [ 234.945598][ T28] ? watchdog.cold+0x130/0x158 [ 234.945651][ T28] watchdog.cold+0x141/0x158 [ 234.945684][ T28] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 234.945716][ T28] kthread+0x2e9/0x3a0 [ 234.945738][ T28] ? kthread_complete_and_exit+0x40/0x40 [ 234.945764][ T28] ret_from_fork+0x1f/0x30 [ 234.945804][ T28] [ 234.952119][ T28] Kernel Offset: disabled [ 235.360629][ T28] Rebooting in 86400 seconds..