DUID 00:04:06:88:74:a7:04:75:62:cb:55:93:34:09:94:90:e1:fe forked to background, child pid 3180 [ 27.479055][ T3181] 8021q: adding VLAN 0 to HW filter on device bond0 [ 27.513722][ T3181] eql: remember to turn off Van-Jacobson compression on your slave devices Starting sshd: OK syzkaller syzkaller login: [ 76.223246][ T141] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.0.221' (ECDSA) to the list of known hosts. 2022/01/19 20:09:26 parsed 1 programs [ 487.061724][ T3641] cgroup: Unknown subsys name 'net' [ 487.170359][ T3641] cgroup: Unknown subsys name 'rlimit' 2022/01/19 20:09:26 executed programs: 0 [ 488.487557][ T3670] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1 [ 488.487683][ T3669] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 488.495385][ T3670] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1 [ 488.503040][ T3669] Bluetooth: hci3: unexpected cc 0x0c03 length: 249 > 1 [ 488.511043][ T3670] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9 [ 488.517107][ T3669] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 488.523302][ T3670] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9 [ 488.531604][ T3669] Bluetooth: hci3: unexpected cc 0x1003 length: 249 > 9 [ 488.537591][ T3670] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9 [ 488.547623][ T3669] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 488.551672][ T3670] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9 [ 488.569965][ T3669] Bluetooth: hci3: unexpected cc 0x1001 length: 249 > 9 [ 488.575189][ T3674] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4 [ 488.577960][ T3669] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4 [ 488.584565][ T3674] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3 [ 488.599203][ T3674] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2 [ 488.600082][ T3669] Bluetooth: hci5: unexpected cc 0x0c03 length: 249 > 1 [ 488.606528][ T3674] Bluetooth: hci4: unexpected cc 0x0c03 length: 249 > 1 [ 488.615165][ T3669] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 488.628304][ T3674] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3 [ 488.628758][ T3669] Bluetooth: hci3: unexpected cc 0x0c23 length: 249 > 4 [ 488.636706][ T3662] Bluetooth: hci5: unexpected cc 0x1003 length: 249 > 9 [ 488.645155][ T3669] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2 [ 488.649570][ T3674] Bluetooth: hci4: unexpected cc 0x1003 length: 249 > 9 [ 488.658170][ T3669] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 488.663623][ T3662] Bluetooth: hci3: unexpected cc 0x0c25 length: 249 > 3 [ 488.678899][ T3666] Bluetooth: hci5: unexpected cc 0x1001 length: 249 > 9 [ 488.686176][ T3675] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 488.686883][ T3666] Bluetooth: hci4: unexpected cc 0x1001 length: 249 > 9 [ 488.702560][ T3676] Bluetooth: hci3: unexpected cc 0x0c38 length: 249 > 2 [ 488.703999][ T3666] Bluetooth: hci5: unexpected cc 0x0c23 length: 249 > 4 [ 488.722034][ T3666] Bluetooth: hci5: unexpected cc 0x0c25 length: 249 > 3 [ 488.735188][ T3666] Bluetooth: hci5: unexpected cc 0x0c38 length: 249 > 2 [ 488.756796][ T3668] Bluetooth: hci4: unexpected cc 0x0c23 length: 249 > 4 [ 488.766650][ T3668] Bluetooth: hci4: unexpected cc 0x0c25 length: 249 > 3 [ 488.774270][ T3668] Bluetooth: hci4: unexpected cc 0x0c38 length: 249 > 2 [ 489.058706][ T3655] chnl_net:caif_netlink_parms(): no params data found [ 489.134413][ T3654] chnl_net:caif_netlink_parms(): no params data found [ 489.196327][ T3656] chnl_net:caif_netlink_parms(): no params data found [ 489.206759][ T3657] chnl_net:caif_netlink_parms(): no params data found [ 489.283507][ T3659] chnl_net:caif_netlink_parms(): no params data found [ 489.312863][ T3658] chnl_net:caif_netlink_parms(): no params data found [ 489.339724][ T3655] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.347733][ T3655] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.355887][ T3655] device bridge_slave_0 entered promiscuous mode [ 489.386748][ T3655] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.394817][ T3655] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.403574][ T3655] device bridge_slave_1 entered promiscuous mode [ 489.504065][ T3654] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.514732][ T3654] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.523560][ T3654] device bridge_slave_0 entered promiscuous mode [ 489.548121][ T3655] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 489.562676][ T3657] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.569776][ T3657] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.578855][ T3657] device bridge_slave_0 entered promiscuous mode [ 489.587113][ T3654] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.594960][ T3654] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.603407][ T3654] device bridge_slave_1 entered promiscuous mode [ 489.617730][ T3656] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.624932][ T3656] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.633616][ T3656] device bridge_slave_0 entered promiscuous mode [ 489.643050][ T3655] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 489.660905][ T3657] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.668055][ T3657] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.676454][ T3657] device bridge_slave_1 entered promiscuous mode [ 489.712655][ T3656] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.719753][ T3656] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.727697][ T3656] device bridge_slave_1 entered promiscuous mode [ 489.783330][ T3655] team0: Port device team_slave_0 added [ 489.791016][ T3657] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 489.802245][ T3654] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 489.811850][ T3659] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.818925][ T3659] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.827057][ T3659] device bridge_slave_0 entered promiscuous mode [ 489.834892][ T3658] bridge0: port 1(bridge_slave_0) entered blocking state [ 489.842026][ T3658] bridge0: port 1(bridge_slave_0) entered disabled state [ 489.849795][ T3658] device bridge_slave_0 entered promiscuous mode [ 489.868608][ T3655] team0: Port device team_slave_1 added [ 489.875854][ T3657] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 489.886876][ T3654] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 489.896425][ T3659] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.904167][ T3659] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.912518][ T3659] device bridge_slave_1 entered promiscuous mode [ 489.919389][ T3658] bridge0: port 2(bridge_slave_1) entered blocking state [ 489.928657][ T3658] bridge0: port 2(bridge_slave_1) entered disabled state [ 489.937008][ T3658] device bridge_slave_1 entered promiscuous mode [ 489.947156][ T3656] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 490.001568][ T3656] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 490.027210][ T3654] team0: Port device team_slave_0 added [ 490.055811][ T3655] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.063231][ T3655] 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. [ 490.089583][ T3655] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.104804][ T3657] team0: Port device team_slave_0 added [ 490.112129][ T3654] team0: Port device team_slave_1 added [ 490.119442][ T3659] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 490.131351][ T3658] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 490.154498][ T3655] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 490.162095][ T3655] 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. [ 490.188532][ T3655] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 490.200888][ T3657] team0: Port device team_slave_1 added [ 490.214192][ T3659] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 490.224967][ T3658] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 490.238520][ T3656] team0: Port device team_slave_0 added [ 490.247769][ T3656] team0: Port device team_slave_1 added [ 490.307220][ T3654] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.314806][ T3654] 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. [ 490.341035][ T3654] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.355698][ T3654] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 490.362816][ T3654] 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. [ 490.389325][ T3654] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 490.418265][ T3658] team0: Port device team_slave_0 added [ 490.430813][ T3657] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.437962][ T3657] 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. [ 490.464215][ T3657] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.479430][ T3659] team0: Port device team_slave_0 added [ 490.492785][ T3658] team0: Port device team_slave_1 added [ 490.499009][ T3656] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.506012][ T3656] 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. [ 490.531996][ T3656] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.552842][ T3657] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 490.559816][ T3657] 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. [ 490.586527][ T3657] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 490.601638][ T3659] team0: Port device team_slave_1 added [ 490.610868][ T3655] device hsr_slave_0 entered promiscuous mode [ 490.617986][ T3655] device hsr_slave_1 entered promiscuous mode [ 490.634109][ T3656] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 490.641070][ T3656] 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. [ 490.667106][ T3656] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 490.712261][ T3661] Bluetooth: hci1: command 0x0409 tx timeout [ 490.724163][ T3654] device hsr_slave_0 entered promiscuous mode [ 490.730777][ T3654] device hsr_slave_1 entered promiscuous mode [ 490.737662][ T3654] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 490.745690][ T3654] Cannot create hsr debugfs directory [ 490.779524][ T3659] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.781344][ T3269] Bluetooth: hci5: command 0x0409 tx timeout [ 490.786739][ T3661] Bluetooth: hci0: command 0x0409 tx timeout [ 490.796657][ T3269] Bluetooth: hci3: command 0x0409 tx timeout [ 490.798706][ T3659] 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. [ 490.830784][ T3659] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.842772][ T3658] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 490.849742][ T3658] 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. [ 490.861409][ T3269] Bluetooth: hci2: command 0x0409 tx timeout [ 490.875764][ T3658] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 490.892768][ T3269] Bluetooth: hci4: command 0x0409 tx timeout [ 490.895648][ T3657] device hsr_slave_0 entered promiscuous mode [ 490.906258][ T3657] device hsr_slave_1 entered promiscuous mode [ 490.912971][ T3657] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 490.920521][ T3657] Cannot create hsr debugfs directory [ 490.940085][ T3659] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 490.947354][ T3659] 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. [ 490.973584][ T3659] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 490.994293][ T3658] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 491.001695][ T3658] 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. [ 491.027944][ T3658] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 491.055992][ T3656] device hsr_slave_0 entered promiscuous mode [ 491.062859][ T3656] device hsr_slave_1 entered promiscuous mode [ 491.069388][ T3656] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 491.077786][ T3656] Cannot create hsr debugfs directory [ 491.148956][ T3659] device hsr_slave_0 entered promiscuous mode [ 491.155901][ T3659] device hsr_slave_1 entered promiscuous mode [ 491.162725][ T3659] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 491.170272][ T3659] Cannot create hsr debugfs directory [ 491.252537][ T3658] device hsr_slave_0 entered promiscuous mode [ 491.259388][ T3658] device hsr_slave_1 entered promiscuous mode [ 491.270440][ T3658] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 491.278195][ T3658] Cannot create hsr debugfs directory [ 491.525794][ T3655] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 491.556583][ T3655] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 491.576201][ T3655] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 491.588632][ T3655] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 491.614062][ T3654] netdevsim netdevsim3 netdevsim0: renamed from eth0 [ 491.624200][ T3654] netdevsim netdevsim3 netdevsim1: renamed from eth1 [ 491.638799][ T3654] netdevsim netdevsim3 netdevsim2: renamed from eth2 [ 491.662611][ T3654] netdevsim netdevsim3 netdevsim3: renamed from eth3 [ 491.716236][ T3657] netdevsim netdevsim2 netdevsim0: renamed from eth0 [ 491.734276][ T3657] netdevsim netdevsim2 netdevsim1: renamed from eth1 [ 491.747920][ T3657] netdevsim netdevsim2 netdevsim2: renamed from eth2 [ 491.787208][ T3657] netdevsim netdevsim2 netdevsim3: renamed from eth3 [ 491.817720][ T3656] netdevsim netdevsim5 netdevsim0: renamed from eth0 [ 491.848316][ T3656] netdevsim netdevsim5 netdevsim1: renamed from eth1 [ 491.866297][ T3655] 8021q: adding VLAN 0 to HW filter on device bond0 [ 491.888927][ T3656] netdevsim netdevsim5 netdevsim2: renamed from eth2 [ 491.900122][ T3656] netdevsim netdevsim5 netdevsim3: renamed from eth3 [ 491.934444][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 491.944329][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 491.956576][ T3659] netdevsim netdevsim1 netdevsim0: renamed from eth0 [ 491.977130][ T3655] 8021q: adding VLAN 0 to HW filter on device team0 [ 491.987831][ T3659] netdevsim netdevsim1 netdevsim1: renamed from eth1 [ 492.027785][ T3659] netdevsim netdevsim1 netdevsim2: renamed from eth2 [ 492.037583][ T3659] netdevsim netdevsim1 netdevsim3: renamed from eth3 [ 492.047064][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 492.057133][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 492.067063][ T3707] bridge0: port 1(bridge_slave_0) entered blocking state [ 492.074472][ T3707] bridge0: port 1(bridge_slave_0) entered forwarding state [ 492.086869][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 492.101331][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 492.109883][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 492.118887][ T3708] bridge0: port 2(bridge_slave_1) entered blocking state [ 492.126016][ T3708] bridge0: port 2(bridge_slave_1) entered forwarding state [ 492.134599][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 492.159896][ T3654] 8021q: adding VLAN 0 to HW filter on device bond0 [ 492.182207][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 492.192100][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 492.200900][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 492.209868][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 492.219052][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 492.228431][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 492.237480][ T3658] netdevsim netdevsim4 netdevsim0: renamed from eth0 [ 492.249367][ T3658] netdevsim netdevsim4 netdevsim1: renamed from eth1 [ 492.258272][ T3658] netdevsim netdevsim4 netdevsim2: renamed from eth2 [ 492.268557][ T3658] netdevsim netdevsim4 netdevsim3: renamed from eth3 [ 492.311766][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 492.319712][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 492.328515][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 492.337485][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 492.354158][ T3654] 8021q: adding VLAN 0 to HW filter on device team0 [ 492.387162][ T3657] 8021q: adding VLAN 0 to HW filter on device bond0 [ 492.397982][ T3655] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 492.409771][ T3655] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 492.420142][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 492.429160][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 492.462339][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 492.472183][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 492.480555][ T3709] bridge0: port 1(bridge_slave_0) entered blocking state [ 492.487682][ T3709] bridge0: port 1(bridge_slave_0) entered forwarding state [ 492.524799][ T3657] 8021q: adding VLAN 0 to HW filter on device team0 [ 492.536037][ T3656] 8021q: adding VLAN 0 to HW filter on device bond0 [ 492.551972][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 492.559842][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 492.569294][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 492.578154][ T3707] bridge0: port 2(bridge_slave_1) entered blocking state [ 492.585314][ T3707] bridge0: port 2(bridge_slave_1) entered forwarding state [ 492.593393][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 492.601081][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 492.609227][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 492.617922][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 492.631886][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 492.639447][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 492.669963][ T3656] 8021q: adding VLAN 0 to HW filter on device team0 [ 492.680352][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 492.689705][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 492.698323][ T3642] bridge0: port 1(bridge_slave_0) entered blocking state [ 492.705452][ T3642] bridge0: port 1(bridge_slave_0) entered forwarding state [ 492.715138][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 492.724074][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 492.732640][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 492.741847][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 492.750367][ T3642] bridge0: port 2(bridge_slave_1) entered blocking state [ 492.757519][ T3642] bridge0: port 2(bridge_slave_1) entered forwarding state [ 492.765403][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 492.774462][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 492.783293][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 492.790997][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 492.812884][ T3711] Bluetooth: hci1: command 0x041b tx timeout [ 492.839499][ T3655] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 492.859709][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 492.868437][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 492.877093][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 492.886182][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 492.894850][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 492.903638][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 492.912407][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 492.920953][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 492.929830][ T3705] bridge0: port 1(bridge_slave_0) entered blocking state [ 492.936944][ T3705] bridge0: port 1(bridge_slave_0) entered forwarding state [ 492.945252][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 492.954717][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 492.964012][ T3705] Bluetooth: hci3: command 0x041b tx timeout [ 492.982127][ T3705] Bluetooth: hci0: command 0x041b tx timeout [ 492.996031][ T3654] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 493.003248][ T3705] Bluetooth: hci5: command 0x041b tx timeout [ 493.024974][ T3711] Bluetooth: hci4: command 0x041b tx timeout [ 493.031434][ T3711] Bluetooth: hci2: command 0x041b tx timeout [ 493.033843][ T3658] 8021q: adding VLAN 0 to HW filter on device bond0 [ 493.057280][ T3657] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 493.077505][ T3657] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 493.099995][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 493.109424][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 493.118469][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 493.127358][ T3642] bridge0: port 2(bridge_slave_1) entered blocking state [ 493.134472][ T3642] bridge0: port 2(bridge_slave_1) entered forwarding state [ 493.142609][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 493.151380][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 493.160179][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 493.168781][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 493.177768][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 493.186620][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 493.195309][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 493.204243][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 493.212918][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 493.240392][ T3659] 8021q: adding VLAN 0 to HW filter on device bond0 [ 493.252994][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 493.261032][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 493.270142][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 493.279318][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 493.289216][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 493.298315][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 493.306374][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 493.314486][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 493.323798][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 493.333035][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 493.349017][ T3654] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 493.366687][ T3656] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 493.385145][ T3656] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 493.402545][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 493.418942][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 493.429360][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 493.438214][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 493.447138][ T3707] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 493.469112][ T3659] 8021q: adding VLAN 0 to HW filter on device team0 [ 493.506776][ T3658] 8021q: adding VLAN 0 to HW filter on device team0 [ 493.516886][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 493.527310][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 493.537206][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 493.545300][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 493.553338][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 493.561095][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 493.575733][ T3657] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 493.608802][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 493.625249][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 493.645914][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 493.662855][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 493.672356][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 493.681052][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 493.690108][ T3642] bridge0: port 1(bridge_slave_0) entered blocking state [ 493.697279][ T3642] bridge0: port 1(bridge_slave_0) entered forwarding state [ 493.705789][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 493.714735][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 493.724060][ T3642] bridge0: port 2(bridge_slave_1) entered blocking state [ 493.731226][ T3642] bridge0: port 2(bridge_slave_1) entered forwarding state [ 493.739223][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 493.749079][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 493.758220][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 493.767150][ T3642] bridge0: port 1(bridge_slave_0) entered blocking state [ 493.774590][ T3642] bridge0: port 1(bridge_slave_0) entered forwarding state [ 493.782648][ T3642] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 493.795428][ T3656] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 493.829232][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 493.838608][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 493.866717][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 493.899867][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 493.923034][ T3710] bridge0: port 2(bridge_slave_1) entered blocking state [ 493.930177][ T3710] bridge0: port 2(bridge_slave_1) entered forwarding state [ 493.938247][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 493.947510][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 493.956599][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 493.966115][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 493.974827][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 493.984092][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 493.999781][ T3655] device veth0_vlan entered promiscuous mode [ 494.035389][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 494.052224][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 494.064414][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 494.088578][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 494.108694][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 494.118165][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 494.127178][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 494.136144][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 494.145761][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 494.154462][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 494.162994][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 494.171507][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 494.179754][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 494.188535][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 494.197259][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 494.206935][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 494.215548][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 494.223711][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 494.236603][ T3655] device veth1_vlan entered promiscuous mode [ 494.248164][ T3659] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 494.276243][ T3658] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 494.288513][ T3658] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 494.301518][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 494.310090][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 494.320183][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 494.329021][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 494.348723][ T3654] device veth0_vlan entered promiscuous mode [ 494.381822][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 494.390271][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 494.412445][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 494.425424][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 494.447412][ T3654] device veth1_vlan entered promiscuous mode [ 494.469340][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 494.477593][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 494.486433][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 494.495577][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 494.508473][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 494.521365][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 494.528888][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 494.545290][ T3655] device veth0_macvtap entered promiscuous mode [ 494.558807][ T3657] device veth0_vlan entered promiscuous mode [ 494.570764][ T3658] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 494.583887][ T3659] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 494.601768][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 494.610133][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 494.620245][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 494.629979][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 494.648183][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 494.658899][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 494.676222][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 494.686295][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 494.694988][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 494.703249][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 494.717197][ T3657] device veth1_vlan entered promiscuous mode [ 494.727819][ T3654] device veth0_macvtap entered promiscuous mode [ 494.739804][ T3655] device veth1_macvtap entered promiscuous mode [ 494.804572][ T3654] device veth1_macvtap entered promiscuous mode [ 494.833865][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 494.847575][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 494.860873][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 494.874456][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 494.883260][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 494.891298][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 494.899991][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 494.909003][ T3679] Bluetooth: hci1: command 0x040f tx timeout [ 494.937634][ T3655] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 494.956935][ T3656] device veth0_vlan entered promiscuous mode [ 494.973524][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 494.992009][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 495.000859][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 495.019798][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 495.021820][ T3705] Bluetooth: hci5: command 0x040f tx timeout [ 495.040583][ T3657] device veth0_macvtap entered promiscuous mode [ 495.053482][ T3655] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 495.062443][ T3654] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.063743][ T3705] Bluetooth: hci0: command 0x040f tx timeout [ 495.079477][ T3654] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.091369][ T3705] Bluetooth: hci3: command 0x040f tx timeout [ 495.094598][ T3654] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 495.102354][ T3708] Bluetooth: hci2: command 0x040f tx timeout [ 495.110292][ T3656] device veth1_vlan entered promiscuous mode [ 495.118128][ T3708] Bluetooth: hci4: command 0x040f tx timeout [ 495.119115][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 495.132703][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 495.140421][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 495.148847][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 495.158199][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 495.167797][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 495.177220][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 495.186542][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 495.196004][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 495.207833][ T3657] device veth1_macvtap entered promiscuous mode [ 495.226906][ T3654] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 495.245549][ T3654] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.260826][ T3654] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 495.275643][ T3655] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.285930][ T3655] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.295242][ T3655] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.305114][ T3655] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.316137][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 495.325992][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 495.334779][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 495.343343][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 495.352667][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 495.372171][ T3654] netdevsim netdevsim3 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.380940][ T3654] netdevsim netdevsim3 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.391107][ T3654] netdevsim netdevsim3 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.402678][ T3654] netdevsim netdevsim3 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.456155][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 495.474881][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 495.490363][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 495.499839][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 495.524396][ T3657] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.536251][ T3657] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.548132][ T3657] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.558874][ T3657] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.570171][ T3657] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 495.582198][ T3657] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 495.596167][ T3657] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.606719][ T3657] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 495.619317][ T3657] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.640207][ T3657] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 495.657972][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 495.667703][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 495.678783][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 495.687693][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 495.700374][ T3656] device veth0_macvtap entered promiscuous mode [ 495.716688][ T3656] device veth1_macvtap entered promiscuous mode [ 495.742618][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 495.750833][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 495.768125][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 495.778649][ T3709] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 495.793940][ T3657] netdevsim netdevsim2 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.804150][ T3657] netdevsim netdevsim2 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.813369][ T3657] netdevsim netdevsim2 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.825686][ T3657] netdevsim netdevsim2 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 495.869988][ T3659] device veth0_vlan entered promiscuous mode [ 495.885285][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 495.894167][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 495.922006][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.935925][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.946094][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.956832][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.966844][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 495.977563][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 495.990779][ T3656] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 496.026156][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 496.033990][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 496.046121][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 496.054980][ T3706] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 496.077417][ T3658] device veth0_vlan entered promiscuous mode [ 496.092892][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 496.103763][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.114099][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 496.124864][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.134998][ T3656] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 496.146120][ T3656] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.158132][ T3656] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 496.176686][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 496.177888][ T3703] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 496.192067][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 496.197939][ T3703] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 496.209520][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 496.218222][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 496.228361][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 496.239075][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 496.247169][ T3708] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 496.258574][ T3703] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 496.259968][ T3656] netdevsim netdevsim5 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 496.270812][ T3703] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 496.276474][ T3656] netdevsim netdevsim5 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 496.291831][ T3656] netdevsim netdevsim5 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 496.300545][ T3656] netdevsim netdevsim5 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 496.319684][ T3659] device veth1_vlan entered promiscuous mode [ 496.342106][ T3658] device veth1_vlan entered promiscuous mode [ 496.358203][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 496.368043][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 496.376741][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 496.490205][ T3658] device veth0_macvtap entered promiscuous mode [ 496.502060][ T3703] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 496.522588][ T50] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 496.526544][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 496.530589][ T50] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 496.539506][ T3703] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 496.555640][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 496.566003][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 496.574344][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 496.583807][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 496.602164][ T3658] device veth1_macvtap entered promiscuous mode [ 496.613861][ T3659] device veth0_macvtap entered promiscuous mode [ 496.645534][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 496.662765][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 496.678515][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 496.688355][ T3710] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 496.715474][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.728150][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.738382][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.749272][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.759335][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.770181][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.780320][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.792254][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.805384][ T3658] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 496.820123][ T3659] device veth1_macvtap entered promiscuous mode [ 496.821741][ T10] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 496.840499][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.851610][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.858674][ T10] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 496.864108][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.879513][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.889598][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.900550][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.911512][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.922186][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.932509][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 496.943515][ T3708] Bluetooth: hci1: command 0x0419 tx timeout [ 496.945091][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 496.963263][ T3659] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 496.983830][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 496.993197][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 497.001587][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 497.010844][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 497.020217][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 497.029811][ T3705] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 497.049236][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.067111][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.077185][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.089188][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.092476][ T3764] vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(4) [ 497.105726][ T3764] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 497.109789][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.114322][ T3708] Bluetooth: hci3: command 0x0419 tx timeout [ 497.131009][ T3708] Bluetooth: hci0: command 0x0419 tx timeout [ 497.137181][ T3708] Bluetooth: hci5: command 0x0419 tx timeout [ 497.148018][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.148022][ T3764] vhci_hcd vhci_hcd.0: Device attached [ 497.160755][ T3659] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.165400][ T3765] vhci_hcd: connection closed [ 497.175650][ T3659] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.182974][ T50] vhci_hcd: stop threads [ 497.191210][ T3710] Bluetooth: hci4: command 0x0419 tx timeout [ 497.201749][ T3710] Bluetooth: hci2: command 0x0419 tx timeout [ 497.208318][ T50] vhci_hcd: release socket [ 497.216024][ T50] vhci_hcd: disconnect device [ 497.216892][ T3659] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 497.231558][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.243056][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.253549][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.267783][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.278176][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.288868][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.298962][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.309840][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.323037][ T3658] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 497.333786][ T3658] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 497.345531][ T3658] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 497.372486][ T3762] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 497.379447][ T10] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 497.392012][ T3762] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 497.398543][ T10] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 497.412771][ T3762] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 497.426686][ T3762] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 497.436088][ T3762] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 497.437882][ T3769] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 497.449876][ T3769] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 497.468519][ T50] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 497.479892][ T50] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 497.490228][ T3659] netdevsim netdevsim1 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.492782][ T3769] vhci_hcd vhci_hcd.0: Device attached [ 497.506597][ T3659] netdevsim netdevsim1 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.515723][ T3659] netdevsim netdevsim1 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.528760][ T3659] netdevsim netdevsim1 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.550884][ T3660] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 497.562631][ T3658] netdevsim netdevsim4 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.571811][ T3658] netdevsim netdevsim4 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.580543][ T3658] netdevsim netdevsim4 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 497.592934][ T3658] netdevsim netdevsim4 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 2022/01/19 20:09:37 executed programs: 6 [ 497.633996][ T3704] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 497.654237][ T3704] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 497.713866][ T3269] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 497.796314][ T3774] vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(4) [ 497.801669][ T3709] vhci_hcd: vhci_device speed not set [ 497.802900][ T3774] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 497.839690][ T3774] vhci_hcd vhci_hcd.0: Device attached [ 497.849064][ T3779] vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(4) [ 497.855636][ T3779] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 497.866718][ T3779] vhci_hcd vhci_hcd.0: Device attached [ 497.892351][ T3709] usb 9-1: new full-speed USB device number 2 using vhci_hcd [ 497.915355][ T3703] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 497.924128][ T3703] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 497.956198][ T25] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 497.963582][ T3785] vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(4) [ 497.963611][ T3785] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 497.964222][ T3785] vhci_hcd vhci_hcd.0: Device attached [ 498.007653][ T10] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 498.026278][ T10] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 498.041796][ T3269] vhci_hcd: vhci_device speed not set [ 498.061043][ T3679] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 498.070132][ T3704] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 498.083260][ T3660] vhci_hcd: vhci_device speed not set [ 498.094786][ T3704] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 498.121366][ T3269] usb 13-1: new full-speed USB device number 2 using vhci_hcd [ 498.146182][ T3784] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 498.146343][ T3703] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 498.162259][ T3660] usb 15-1: new full-speed USB device number 2 using vhci_hcd [ 498.186208][ T3703] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 498.201587][ T25] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 498.217338][ T3679] vhci_hcd: vhci_device speed not set [ 498.302284][ T3679] usb 19-1: new full-speed USB device number 2 using vhci_hcd [ 498.328074][ T3793] vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(4) [ 498.334631][ T3793] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 498.344680][ T3793] vhci_hcd vhci_hcd.0: Device attached [ 498.355677][ T3796] vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(4) [ 498.362216][ T3796] vhci_hcd vhci_hcd.0: devid(0) speed(4) speed_str(wireless) [ 498.370292][ T3796] vhci_hcd vhci_hcd.0: Device attached [ 498.529498][ T3775] vhci_hcd: connection reset by peer [ 498.535286][ T10] vhci_hcd: stop threads [ 498.539681][ T10] vhci_hcd: release socket [ 498.560035][ T10] vhci_hcd: disconnect device [ 498.565459][ T3706] vhci_hcd: vhci_device speed not set [ 498.571008][ T25] vhci_hcd: vhci_device speed not set [ 498.627739][ T3780] vhci_hcd: connection reset by peer [ 498.638345][ T10] vhci_hcd: stop threads [ 498.642823][ T3706] usb 17-1: new full-speed USB device number 2 using vhci_hcd [ 498.645897][ T10] vhci_hcd: release socket [ 498.652474][ T25] usb 11-1: new full-speed USB device number 2 using vhci_hcd [ 498.660774][ T10] vhci_hcd: disconnect device [ 498.731792][ T3786] vhci_hcd: connection reset by peer [ 498.737519][ T10] vhci_hcd: stop threads [ 498.742427][ T10] vhci_hcd: release socket [ 498.748623][ T10] vhci_hcd: disconnect device [ 499.108337][ T3794] vhci_hcd: connection reset by peer [ 499.114018][ T3704] vhci_hcd: stop threads [ 499.118542][ T3704] vhci_hcd: release socket [ 499.123326][ T3704] vhci_hcd: disconnect device [ 499.132204][ T3797] vhci_hcd: connection reset by peer [ 499.138300][ T10] vhci_hcd: stop threads [ 499.142958][ T10] vhci_hcd: release socket [ 499.147480][ T10] vhci_hcd: disconnect device [ 501.193058][ T1232] ieee802154 phy0 wpan0: encryption failed: -22 [ 501.199725][ T1232] ieee802154 phy1 wpan1: encryption failed: -22 [ 503.262212][ T3269] vhci_hcd: vhci_device speed not set [ 503.281417][ T3660] vhci_hcd: vhci_device speed not set [ 503.431872][ T3679] vhci_hcd: vhci_device speed not set [ 503.842536][ T25] vhci_hcd: vhci_device speed not set [ 503.848045][ T3706] vhci_hcd: vhci_device speed not set [ 562.632366][ T1232] ieee802154 phy0 wpan0: encryption failed: -22 [ 562.638673][ T1232] ieee802154 phy1 wpan1: encryption failed: -22 [ 610.791258][ T3660] Bluetooth: hci1: command 0x0406 tx timeout [ 615.901405][ T3784] Bluetooth: hci0: command 0x0406 tx timeout [ 615.907466][ T3784] Bluetooth: hci3: command 0x0406 tx timeout [ 615.927239][ T3784] Bluetooth: hci5: command 0x0406 tx timeout [ 615.936048][ T3784] Bluetooth: hci4: command 0x0406 tx timeout [ 615.946019][ T3784] Bluetooth: hci2: command 0x0406 tx timeout [ 624.065921][ T1232] ieee802154 phy0 wpan0: encryption failed: -22 [ 624.072300][ T1232] ieee802154 phy1 wpan1: encryption failed: -22 [ 650.951388][ T27] INFO: task kworker/1:6:3709 blocked for more than 143 seconds. [ 650.959339][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 650.966190][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 650.974940][ T27] task:kworker/1:6 state:D stack:26416 pid: 3709 ppid: 2 flags:0x00004000 [ 650.984248][ T27] Workqueue: usb_hub_wq hub_event [ 650.989456][ T27] Call Trace: [ 650.992795][ T27] [ 650.995745][ T27] __schedule+0xab2/0x4e90 [ 651.000341][ T27] ? find_held_lock+0x2d/0x110 [ 651.005234][ T27] ? mark_held_locks+0x52/0xe0 [ 651.010050][ T27] ? io_schedule_timeout+0x180/0x180 [ 651.016245][ T27] ? lockdep_hardirqs_on+0x79/0x100 [ 651.022371][ T27] schedule+0xd2/0x260 [ 651.026495][ T27] usb_kill_urb.part.0+0x19a/0x220 [ 651.031793][ T27] ? usb_anchor_suspend_wakeups+0x40/0x40 [ 651.037546][ T27] ? finish_wait+0x270/0x270 [ 651.042742][ T27] usb_kill_urb+0x7f/0xa0 [ 651.047118][ T27] usb_start_wait_urb+0x24a/0x4c0 [ 651.059073][ T27] ? usb_api_blocking_completion+0xa0/0xa0 [ 651.066314][ T27] ? memset+0x20/0x40 [ 651.070477][ T27] usb_control_msg+0x31c/0x4a0 [ 651.081205][ T27] ? usb_start_wait_urb+0x4c0/0x4c0 [ 651.086501][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 651.092227][ T27] hub_port_init+0x7bd/0x2e80 [ 651.096957][ T27] hub_event+0x238a/0x44d0 [ 651.101671][ T27] ? hub_port_debounce+0x3c0/0x3c0 [ 651.106849][ T27] ? lock_release+0x720/0x720 [ 651.111636][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 651.116524][ T27] ? lockdep_hardirqs_on+0x79/0x100 [ 651.123080][ T27] process_one_work+0x996/0x1610 [ 651.128136][ T27] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 651.133590][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 651.138568][ T27] ? _raw_spin_lock_irq+0x41/0x50 [ 651.143738][ T27] worker_thread+0x665/0x1080 [ 651.148454][ T27] ? __kthread_parkme+0x15f/0x220 [ 651.156375][ T27] ? process_one_work+0x1610/0x1610 [ 651.161900][ T27] kthread+0x2e9/0x3a0 [ 651.166219][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 651.172619][ T27] ret_from_fork+0x1f/0x30 [ 651.177122][ T27] [ 651.180200][ T27] INFO: task syz-executor.0:3767 can't die for more than 143 seconds. [ 651.195964][ T27] task:syz-executor.0 state:D stack:28000 pid: 3767 ppid: 3655 flags:0x00000004 [ 651.206644][ T27] Call Trace: [ 651.209926][ T27] [ 651.217861][ T27] __schedule+0xab2/0x4e90 [ 651.224385][ T27] ? io_schedule_timeout+0x180/0x180 [ 651.229734][ T27] schedule+0xd2/0x260 [ 651.236378][ T27] schedule_preempt_disabled+0xf/0x20 [ 651.243119][ T27] __mutex_lock+0xa32/0x12f0 [ 651.247760][ T27] ? usbdev_release+0x83/0x4b0 [ 651.257450][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 651.265956][ T27] ? __fsnotify_parent+0x498/0xa60 [ 651.277137][ T27] ? fsnotify+0x13d0/0x13d0 [ 651.283092][ T27] ? locks_remove_file+0x2f7/0x570 [ 651.288336][ T27] usbdev_release+0x83/0x4b0 [ 651.296419][ T27] __fput+0x286/0x9f0 [ 651.300471][ T27] ? free_async+0x4e0/0x4e0 [ 651.306358][ T27] task_work_run+0xdd/0x1a0 [ 651.310910][ T27] exit_to_user_mode_prepare+0x27e/0x290 [ 651.317080][ T27] syscall_exit_to_user_mode+0x19/0x60 [ 651.326486][ T27] do_syscall_64+0x42/0xb0 [ 651.330960][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 651.340803][ T27] RIP: 0033:0x7ff21c603c2b [ 651.345704][ T27] RSP: 002b:00007ffe6d368d40 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 651.356158][ T27] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007ff21c603c2b [ 651.366257][ T27] RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000003 [ 651.378119][ T27] RBP: 00007ff21c765960 R08: 0000000000000000 R09: 00007ff21c7680d0 [ 651.389050][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000079a2e [ 651.405577][ T27] R13: 00007ffe6d368e40 R14: 00007ffe6d368e60 R15: 0000000000000032 [ 651.415838][ T27] [ 651.418880][ T27] INFO: task syz-executor.0:3767 blocked for more than 143 seconds. [ 651.428232][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 651.435220][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 651.444002][ T27] task:syz-executor.0 state:D stack:28000 pid: 3767 ppid: 3655 flags:0x00000004 [ 651.453428][ T27] Call Trace: [ 651.456769][ T27] [ 651.459693][ T27] __schedule+0xab2/0x4e90 [ 651.464199][ T27] ? io_schedule_timeout+0x180/0x180 [ 651.469515][ T27] schedule+0xd2/0x260 [ 651.473735][ T27] schedule_preempt_disabled+0xf/0x20 [ 651.479134][ T27] __mutex_lock+0xa32/0x12f0 [ 651.485239][ T27] ? usbdev_release+0x83/0x4b0 [ 651.490044][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 651.499808][ T27] ? __fsnotify_parent+0x498/0xa60 [ 651.506514][ T27] ? fsnotify+0x13d0/0x13d0 [ 651.512828][ T27] ? locks_remove_file+0x2f7/0x570 [ 651.518032][ T27] usbdev_release+0x83/0x4b0 [ 651.522900][ T27] __fput+0x286/0x9f0 [ 651.527196][ T27] ? free_async+0x4e0/0x4e0 [ 651.533003][ T27] task_work_run+0xdd/0x1a0 [ 651.537548][ T27] exit_to_user_mode_prepare+0x27e/0x290 [ 651.543443][ T27] syscall_exit_to_user_mode+0x19/0x60 [ 651.548915][ T27] do_syscall_64+0x42/0xb0 [ 651.553761][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 651.559784][ T27] RIP: 0033:0x7ff21c603c2b [ 651.564467][ T27] RSP: 002b:00007ffe6d368d40 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 651.573356][ T27] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007ff21c603c2b [ 651.582173][ T27] RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000003 [ 651.590257][ T27] RBP: 00007ff21c765960 R08: 0000000000000000 R09: 00007ff21c7680d0 [ 651.598679][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000079a2e [ 651.607290][ T27] R13: 00007ffe6d368e40 R14: 00007ffe6d368e60 R15: 0000000000000032 [ 651.615585][ T27] [ 651.618646][ T27] INFO: task syz-executor.2:3773 can't die for more than 144 seconds. [ 651.627232][ T27] task:syz-executor.2 state:D stack:28504 pid: 3773 ppid: 3657 flags:0x00000004 [ 651.637550][ T27] Call Trace: [ 651.640856][ T27] [ 651.643918][ T27] __schedule+0xab2/0x4e90 [ 651.648366][ T27] ? io_schedule_timeout+0x180/0x180 [ 651.653878][ T27] schedule+0xd2/0x260 [ 651.657971][ T27] schedule_preempt_disabled+0xf/0x20 [ 651.663771][ T27] __mutex_lock+0xa32/0x12f0 [ 651.668397][ T27] ? usbdev_open+0x19d/0x920 [ 651.673100][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 651.678670][ T27] ? device_match_of_node+0x50/0x50 [ 651.684022][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 651.689599][ T27] usbdev_open+0x19d/0x920 [ 651.694160][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 651.700560][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 651.707301][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 651.718249][ T27] ? async_completed+0xad0/0xad0 [ 651.723477][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 651.728478][ T27] ? async_completed+0xad0/0xad0 [ 651.734994][ T27] chrdev_open+0x266/0x770 [ 651.739458][ T27] ? cdev_device_add+0x210/0x210 [ 651.745069][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 651.750567][ T27] do_dentry_open+0x4b9/0x1240 [ 651.755784][ T27] ? cdev_device_add+0x210/0x210 [ 651.760758][ T27] ? may_open+0x1f6/0x420 [ 651.765423][ T27] path_openat+0x1c9e/0x2940 [ 651.770020][ T27] ? path_lookupat+0x860/0x860 [ 651.775258][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 651.781563][ T27] do_filp_open+0x1aa/0x400 [ 651.786093][ T27] ? may_open_dev+0xf0/0xf0 [ 651.790626][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 651.796090][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 651.802604][ T27] ? _find_next_bit+0x1e3/0x260 [ 651.807552][ T27] ? _raw_spin_unlock+0x24/0x40 [ 651.812795][ T27] ? alloc_fd+0x2f0/0x670 [ 651.817231][ T27] do_sys_openat2+0x16d/0x4d0 [ 651.823104][ T27] ? build_open_flags+0x6f0/0x6f0 [ 651.828174][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 651.835224][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 651.840164][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 651.846413][ T27] __x64_sys_openat+0x13f/0x1f0 [ 651.851604][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 651.856592][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 651.862869][ T27] do_syscall_64+0x35/0xb0 [ 651.867347][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 651.873660][ T27] RIP: 0033:0x7f3be7549f04 [ 651.878089][ T27] RSP: 002b:00007f3be6d0bca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 651.886774][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f3be7549f04 [ 651.895089][ T27] RDX: 0000000000028101 RSI: 00007f3be6d0bd40 RDI: 00000000ffffff9c [ 651.903462][ T27] RBP: 00007f3be6d0bd40 R08: 0000000000000000 R09: 0000000000000000 [ 651.911791][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 651.919797][ T27] R13: 00007ffcf9aa18df R14: 00007f3be6d0c300 R15: 0000000000022000 [ 651.928145][ T27] [ 651.934680][ T27] INFO: task syz-executor.2:3773 blocked for more than 144 seconds. [ 651.943839][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 651.950712][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 651.959616][ T27] task:syz-executor.2 state:D stack:28504 pid: 3773 ppid: 3657 flags:0x00000004 [ 651.968914][ T27] Call Trace: [ 651.972369][ T27] [ 651.975323][ T27] __schedule+0xab2/0x4e90 [ 651.979789][ T27] ? io_schedule_timeout+0x180/0x180 [ 651.985284][ T27] schedule+0xd2/0x260 [ 651.989385][ T27] schedule_preempt_disabled+0xf/0x20 [ 651.994891][ T27] __mutex_lock+0xa32/0x12f0 [ 651.999505][ T27] ? usbdev_open+0x19d/0x920 [ 652.004218][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 652.009789][ T27] ? device_match_of_node+0x50/0x50 [ 652.015150][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 652.020741][ T27] usbdev_open+0x19d/0x920 [ 652.025251][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 652.034606][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 652.041751][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 652.047428][ T27] ? async_completed+0xad0/0xad0 [ 652.052478][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.057448][ T27] ? async_completed+0xad0/0xad0 [ 652.063035][ T27] chrdev_open+0x266/0x770 [ 652.067488][ T27] ? cdev_device_add+0x210/0x210 [ 652.072613][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 652.078051][ T27] do_dentry_open+0x4b9/0x1240 [ 652.083059][ T27] ? cdev_device_add+0x210/0x210 [ 652.088057][ T27] ? may_open+0x1f6/0x420 [ 652.092570][ T27] path_openat+0x1c9e/0x2940 [ 652.097296][ T27] ? path_lookupat+0x860/0x860 [ 652.102144][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 652.108188][ T27] do_filp_open+0x1aa/0x400 [ 652.112886][ T27] ? may_open_dev+0xf0/0xf0 [ 652.117455][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.122569][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 652.128849][ T27] ? _find_next_bit+0x1e3/0x260 [ 652.133850][ T27] ? _raw_spin_unlock+0x24/0x40 [ 652.138737][ T27] ? alloc_fd+0x2f0/0x670 [ 652.146974][ T27] do_sys_openat2+0x16d/0x4d0 [ 652.151876][ T27] ? build_open_flags+0x6f0/0x6f0 [ 652.156948][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 652.162475][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.167412][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.172396][ T27] __x64_sys_openat+0x13f/0x1f0 [ 652.177274][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 652.182373][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 652.188405][ T27] do_syscall_64+0x35/0xb0 [ 652.192961][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 652.198948][ T27] RIP: 0033:0x7f3be7549f04 [ 652.203425][ T27] RSP: 002b:00007f3be6d0bca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 652.212006][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f3be7549f04 [ 652.219994][ T27] RDX: 0000000000028101 RSI: 00007f3be6d0bd40 RDI: 00000000ffffff9c [ 652.228133][ T27] RBP: 00007f3be6d0bd40 R08: 0000000000000000 R09: 0000000000000000 [ 652.236270][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 652.245205][ T27] R13: 00007ffcf9aa18df R14: 00007f3be6d0c300 R15: 0000000000022000 [ 652.253812][ T27] [ 652.256898][ T27] INFO: task syz-executor.3:3778 can't die for more than 144 seconds. [ 652.269923][ T27] task:syz-executor.3 state:D stack:28504 pid: 3778 ppid: 3654 flags:0x00000004 [ 652.279386][ T27] Call Trace: [ 652.286864][ T27] [ 652.289805][ T27] __schedule+0xab2/0x4e90 [ 652.294940][ T27] ? io_schedule_timeout+0x180/0x180 [ 652.300256][ T27] schedule+0xd2/0x260 [ 652.304985][ T27] schedule_preempt_disabled+0xf/0x20 [ 652.310396][ T27] __mutex_lock+0xa32/0x12f0 [ 652.315361][ T27] ? usbdev_open+0x19d/0x920 [ 652.319958][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 652.325990][ T27] ? device_match_of_node+0x50/0x50 [ 652.331510][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 652.337088][ T27] usbdev_open+0x19d/0x920 [ 652.341896][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 652.348990][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 652.355702][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 652.361724][ T27] ? async_completed+0xad0/0xad0 [ 652.366692][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.372507][ T27] ? async_completed+0xad0/0xad0 [ 652.377504][ T27] chrdev_open+0x266/0x770 [ 652.382329][ T27] ? cdev_device_add+0x210/0x210 [ 652.387318][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 652.392923][ T27] do_dentry_open+0x4b9/0x1240 [ 652.397798][ T27] ? cdev_device_add+0x210/0x210 [ 652.403434][ T27] ? may_open+0x1f6/0x420 [ 652.407809][ T27] path_openat+0x1c9e/0x2940 [ 652.413636][ T27] ? path_lookupat+0x860/0x860 [ 652.418409][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 652.424868][ T27] do_filp_open+0x1aa/0x400 [ 652.429395][ T27] ? may_open_dev+0xf0/0xf0 [ 652.434155][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.439107][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 652.445755][ T27] ? _find_next_bit+0x1e3/0x260 [ 652.450991][ T27] ? _raw_spin_unlock+0x24/0x40 [ 652.456204][ T27] ? alloc_fd+0x2f0/0x670 [ 652.460543][ T27] do_sys_openat2+0x16d/0x4d0 [ 652.474976][ T27] ? build_open_flags+0x6f0/0x6f0 [ 652.480076][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 652.485805][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.490721][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.495995][ T27] __x64_sys_openat+0x13f/0x1f0 [ 652.500982][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 652.506246][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 652.512495][ T27] do_syscall_64+0x35/0xb0 [ 652.516942][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 652.523994][ T27] RIP: 0033:0x7f1ccb53ef04 [ 652.528431][ T27] RSP: 002b:00007f1ccad00ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 652.537106][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f1ccb53ef04 [ 652.545528][ T27] RDX: 0000000000028101 RSI: 00007f1ccad00d40 RDI: 00000000ffffff9c [ 652.554122][ T27] RBP: 00007f1ccad00d40 R08: 0000000000000000 R09: 0000000000000000 [ 652.562416][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 652.570431][ T27] R13: 00007ffee90aa8cf R14: 00007f1ccad01300 R15: 0000000000022000 [ 652.578848][ T27] [ 652.582147][ T27] INFO: task syz-executor.3:3778 blocked for more than 145 seconds. [ 652.590139][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 652.598263][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 652.607152][ T27] task:syz-executor.3 state:D stack:28504 pid: 3778 ppid: 3654 flags:0x00000004 [ 652.616688][ T27] Call Trace: [ 652.619988][ T27] [ 652.623466][ T27] __schedule+0xab2/0x4e90 [ 652.627935][ T27] ? io_schedule_timeout+0x180/0x180 [ 652.634430][ T27] schedule+0xd2/0x260 [ 652.638534][ T27] schedule_preempt_disabled+0xf/0x20 [ 652.644418][ T27] __mutex_lock+0xa32/0x12f0 [ 652.649049][ T27] ? usbdev_open+0x19d/0x920 [ 652.654341][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 652.659933][ T27] ? device_match_of_node+0x50/0x50 [ 652.665481][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 652.671041][ T27] usbdev_open+0x19d/0x920 [ 652.675568][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 652.681902][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 652.688195][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 652.693971][ T27] ? async_completed+0xad0/0xad0 [ 652.698930][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.704997][ T27] ? async_completed+0xad0/0xad0 [ 652.709967][ T27] chrdev_open+0x266/0x770 [ 652.714471][ T27] ? cdev_device_add+0x210/0x210 [ 652.719439][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 652.724976][ T27] do_dentry_open+0x4b9/0x1240 [ 652.729773][ T27] ? cdev_device_add+0x210/0x210 [ 652.734807][ T27] ? may_open+0x1f6/0x420 [ 652.739161][ T27] path_openat+0x1c9e/0x2940 [ 652.744608][ T27] ? path_lookupat+0x860/0x860 [ 652.749396][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 652.755816][ T27] do_filp_open+0x1aa/0x400 [ 652.760356][ T27] ? may_open_dev+0xf0/0xf0 [ 652.765019][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 652.769985][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 652.776288][ T27] ? _find_next_bit+0x1e3/0x260 [ 652.781347][ T27] ? _raw_spin_unlock+0x24/0x40 [ 652.786237][ T27] ? alloc_fd+0x2f0/0x670 [ 652.790602][ T27] do_sys_openat2+0x16d/0x4d0 [ 652.795394][ T27] ? build_open_flags+0x6f0/0x6f0 [ 652.800445][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 652.805992][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.810866][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 652.815993][ T27] __x64_sys_openat+0x13f/0x1f0 [ 652.820902][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 652.829949][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 652.836779][ T27] do_syscall_64+0x35/0xb0 [ 652.844924][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 652.850850][ T27] RIP: 0033:0x7f1ccb53ef04 [ 652.856649][ T27] RSP: 002b:00007f1ccad00ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 652.866365][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f1ccb53ef04 [ 652.874814][ T27] RDX: 0000000000028101 RSI: 00007f1ccad00d40 RDI: 00000000ffffff9c [ 652.883030][ T27] RBP: 00007f1ccad00d40 R08: 0000000000000000 R09: 0000000000000000 [ 652.890999][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 652.899260][ T27] R13: 00007ffee90aa8cf R14: 00007f1ccad01300 R15: 0000000000022000 [ 652.907630][ T27] [ 652.910729][ T27] INFO: task syz-executor.5:3783 can't die for more than 145 seconds. [ 652.920893][ T27] task:syz-executor.5 state:D stack:28152 pid: 3783 ppid: 3656 flags:0x00000004 [ 652.930570][ T27] Call Trace: [ 652.934140][ T27] [ 652.937093][ T27] __schedule+0xab2/0x4e90 [ 652.942041][ T27] ? io_schedule_timeout+0x180/0x180 [ 652.947381][ T27] schedule+0xd2/0x260 [ 652.951868][ T27] schedule_preempt_disabled+0xf/0x20 [ 652.957274][ T27] __mutex_lock+0xa32/0x12f0 [ 652.963388][ T27] ? usbdev_open+0x19d/0x920 [ 652.968068][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 652.973916][ T27] ? device_match_of_node+0x50/0x50 [ 652.979122][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 652.984943][ T27] usbdev_open+0x19d/0x920 [ 652.989359][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 652.996016][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 653.002356][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 653.008040][ T27] ? async_completed+0xad0/0xad0 [ 653.013051][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.018023][ T27] ? async_completed+0xad0/0xad0 [ 653.025088][ T27] chrdev_open+0x266/0x770 [ 653.029552][ T27] ? cdev_device_add+0x210/0x210 [ 653.038414][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 653.045410][ T27] do_dentry_open+0x4b9/0x1240 [ 653.050187][ T27] ? cdev_device_add+0x210/0x210 [ 653.058111][ T27] ? may_open+0x1f6/0x420 [ 653.063645][ T27] path_openat+0x1c9e/0x2940 [ 653.068292][ T27] ? path_lookupat+0x860/0x860 [ 653.073126][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 653.079172][ T27] do_filp_open+0x1aa/0x400 [ 653.083790][ T27] ? may_open_dev+0xf0/0xf0 [ 653.088343][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.093411][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 653.099704][ T27] ? _find_next_bit+0x1e3/0x260 [ 653.104819][ T27] ? _raw_spin_unlock+0x24/0x40 [ 653.109939][ T27] ? alloc_fd+0x2f0/0x670 [ 653.118470][ T27] do_sys_openat2+0x16d/0x4d0 [ 653.123293][ T27] ? build_open_flags+0x6f0/0x6f0 [ 653.128369][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 653.134166][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.139062][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.144224][ T27] __x64_sys_openat+0x13f/0x1f0 [ 653.149101][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 653.154388][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 653.160298][ T27] do_syscall_64+0x35/0xb0 [ 653.166063][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 653.172215][ T27] RIP: 0033:0x7ffbef1d2f04 [ 653.176627][ T27] RSP: 002b:00007ffbee994ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 653.185442][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007ffbef1d2f04 [ 653.193776][ T27] RDX: 0000000000028101 RSI: 00007ffbee994d40 RDI: 00000000ffffff9c [ 653.202086][ T27] RBP: 00007ffbee994d40 R08: 0000000000000000 R09: 0000000000000000 [ 653.210082][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 653.218249][ T27] R13: 00007ffedefc73bf R14: 00007ffbee995300 R15: 0000000000022000 [ 653.226576][ T27] [ 653.229613][ T27] INFO: task syz-executor.5:3783 blocked for more than 145 seconds. [ 653.237694][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 653.244592][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 653.254058][ T27] task:syz-executor.5 state:D stack:28152 pid: 3783 ppid: 3656 flags:0x00000004 [ 653.263486][ T27] Call Trace: [ 653.266780][ T27] [ 653.270031][ T27] __schedule+0xab2/0x4e90 [ 653.274587][ T27] ? io_schedule_timeout+0x180/0x180 [ 653.279950][ T27] schedule+0xd2/0x260 [ 653.284200][ T27] schedule_preempt_disabled+0xf/0x20 [ 653.289594][ T27] __mutex_lock+0xa32/0x12f0 [ 653.294565][ T27] ? usbdev_open+0x19d/0x920 [ 653.299189][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 653.307741][ T27] ? device_match_of_node+0x50/0x50 [ 653.314499][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 653.320056][ T27] usbdev_open+0x19d/0x920 [ 653.327453][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 653.335482][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 653.345778][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 653.354670][ T27] ? async_completed+0xad0/0xad0 [ 653.359722][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.367684][ T27] ? async_completed+0xad0/0xad0 [ 653.373898][ T27] chrdev_open+0x266/0x770 [ 653.378422][ T27] ? cdev_device_add+0x210/0x210 [ 653.383932][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 653.389385][ T27] do_dentry_open+0x4b9/0x1240 [ 653.394644][ T27] ? cdev_device_add+0x210/0x210 [ 653.399599][ T27] ? may_open+0x1f6/0x420 [ 653.404214][ T27] path_openat+0x1c9e/0x2940 [ 653.408816][ T27] ? path_lookupat+0x860/0x860 [ 653.414813][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 653.420854][ T27] do_filp_open+0x1aa/0x400 [ 653.426069][ T27] ? may_open_dev+0xf0/0xf0 [ 653.430613][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.435823][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 653.442375][ T27] ? _find_next_bit+0x1e3/0x260 [ 653.447265][ T27] ? _raw_spin_unlock+0x24/0x40 [ 653.452754][ T27] ? alloc_fd+0x2f0/0x670 [ 653.457127][ T27] do_sys_openat2+0x16d/0x4d0 [ 653.464826][ T27] ? build_open_flags+0x6f0/0x6f0 [ 653.469898][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 653.476289][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.481494][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.486385][ T27] __x64_sys_openat+0x13f/0x1f0 [ 653.491652][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 653.496631][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 653.503287][ T27] do_syscall_64+0x35/0xb0 [ 653.507761][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 653.514095][ T27] RIP: 0033:0x7ffbef1d2f04 [ 653.518529][ T27] RSP: 002b:00007ffbee994ca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 653.527404][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007ffbef1d2f04 [ 653.535622][ T27] RDX: 0000000000028101 RSI: 00007ffbee994d40 RDI: 00000000ffffff9c [ 653.543870][ T27] RBP: 00007ffbee994d40 R08: 0000000000000000 R09: 0000000000000000 [ 653.552232][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 653.560222][ T27] R13: 00007ffedefc73bf R14: 00007ffbee995300 R15: 0000000000022000 [ 653.568485][ T27] [ 653.573412][ T27] INFO: task syz-executor.1:3790 can't die for more than 145 seconds. [ 653.582382][ T27] task:syz-executor.1 state:D stack:28504 pid: 3790 ppid: 3659 flags:0x00000004 [ 653.592472][ T27] Call Trace: [ 653.595768][ T27] [ 653.598692][ T27] __schedule+0xab2/0x4e90 [ 653.603983][ T27] ? io_schedule_timeout+0x180/0x180 [ 653.609310][ T27] schedule+0xd2/0x260 [ 653.613519][ T27] schedule_preempt_disabled+0xf/0x20 [ 653.618922][ T27] __mutex_lock+0xa32/0x12f0 [ 653.624363][ T27] ? usbdev_open+0x19d/0x920 [ 653.628985][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 653.634640][ T27] ? device_match_of_node+0x50/0x50 [ 653.639864][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 653.645492][ T27] usbdev_open+0x19d/0x920 [ 653.649923][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 653.656301][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 653.662940][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 653.668611][ T27] ? async_completed+0xad0/0xad0 [ 653.673664][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.678983][ T27] ? async_completed+0xad0/0xad0 [ 653.684047][ T27] chrdev_open+0x266/0x770 [ 653.688500][ T27] ? cdev_device_add+0x210/0x210 [ 653.693602][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 653.699026][ T27] do_dentry_open+0x4b9/0x1240 [ 653.704285][ T27] ? cdev_device_add+0x210/0x210 [ 653.709275][ T27] ? may_open+0x1f6/0x420 [ 653.717908][ T27] path_openat+0x1c9e/0x2940 [ 653.722728][ T27] ? path_lookupat+0x860/0x860 [ 653.727494][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 653.737815][ T27] do_filp_open+0x1aa/0x400 [ 653.743429][ T27] ? may_open_dev+0xf0/0xf0 [ 653.747959][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 653.757196][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 653.763747][ T27] ? _find_next_bit+0x1e3/0x260 [ 653.768608][ T27] ? _raw_spin_unlock+0x24/0x40 [ 653.777739][ T27] ? alloc_fd+0x2f0/0x670 [ 653.783060][ T27] do_sys_openat2+0x16d/0x4d0 [ 653.787791][ T27] ? build_open_flags+0x6f0/0x6f0 [ 653.795829][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 653.801390][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.806266][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 653.811361][ T27] __x64_sys_openat+0x13f/0x1f0 [ 653.816252][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 653.821637][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 653.827578][ T27] do_syscall_64+0x35/0xb0 [ 653.832152][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 653.838083][ T27] RIP: 0033:0x7fb7dbbeaf04 [ 653.842617][ T27] RSP: 002b:00007fb7db3acca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 653.851116][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007fb7dbbeaf04 [ 653.859101][ T27] RDX: 0000000000028101 RSI: 00007fb7db3acd40 RDI: 00000000ffffff9c [ 653.867176][ T27] RBP: 00007fb7db3acd40 R08: 0000000000000000 R09: 0000000000000000 [ 653.875264][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 653.884227][ T27] R13: 00007ffdd38c69ef R14: 00007fb7db3ad300 R15: 0000000000022000 [ 653.892358][ T27] [ 653.895387][ T27] INFO: task syz-executor.1:3790 blocked for more than 146 seconds. [ 653.903650][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 653.910433][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 653.921210][ T27] task:syz-executor.1 state:D stack:28504 pid: 3790 ppid: 3659 flags:0x00000004 [ 653.930459][ T27] Call Trace: [ 653.933844][ T27] [ 653.936783][ T27] __schedule+0xab2/0x4e90 [ 653.941325][ T27] ? io_schedule_timeout+0x180/0x180 [ 653.946669][ T27] schedule+0xd2/0x260 [ 653.950737][ T27] schedule_preempt_disabled+0xf/0x20 [ 653.956206][ T27] __mutex_lock+0xa32/0x12f0 [ 653.960826][ T27] ? usbdev_open+0x19d/0x920 [ 653.965614][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 653.971358][ T27] ? device_match_of_node+0x50/0x50 [ 653.976617][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 653.982575][ T27] usbdev_open+0x19d/0x920 [ 653.987651][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 653.994065][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 654.000338][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 654.006089][ T27] ? async_completed+0xad0/0xad0 [ 654.011047][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.019142][ T27] ? async_completed+0xad0/0xad0 [ 654.024227][ T27] chrdev_open+0x266/0x770 [ 654.028666][ T27] ? cdev_device_add+0x210/0x210 [ 654.033664][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 654.039067][ T27] do_dentry_open+0x4b9/0x1240 [ 654.043969][ T27] ? cdev_device_add+0x210/0x210 [ 654.048936][ T27] ? may_open+0x1f6/0x420 [ 654.053412][ T27] path_openat+0x1c9e/0x2940 [ 654.058033][ T27] ? path_lookupat+0x860/0x860 [ 654.062977][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 654.068992][ T27] do_filp_open+0x1aa/0x400 [ 654.073572][ T27] ? may_open_dev+0xf0/0xf0 [ 654.078097][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.083184][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 654.090034][ T27] ? _find_next_bit+0x1e3/0x260 [ 654.095014][ T27] ? _raw_spin_unlock+0x24/0x40 [ 654.099896][ T27] ? alloc_fd+0x2f0/0x670 [ 654.104399][ T27] do_sys_openat2+0x16d/0x4d0 [ 654.109111][ T27] ? build_open_flags+0x6f0/0x6f0 [ 654.114315][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 654.119813][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.124997][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.129893][ T27] __x64_sys_openat+0x13f/0x1f0 [ 654.139567][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 654.145341][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 654.155449][ T27] do_syscall_64+0x35/0xb0 [ 654.159881][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 654.166110][ T27] RIP: 0033:0x7fb7dbbeaf04 [ 654.170529][ T27] RSP: 002b:00007fb7db3acca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 654.181292][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007fb7dbbeaf04 [ 654.190135][ T27] RDX: 0000000000028101 RSI: 00007fb7db3acd40 RDI: 00000000ffffff9c [ 654.198223][ T27] RBP: 00007fb7db3acd40 R08: 0000000000000000 R09: 0000000000000000 [ 654.206331][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 654.214417][ T27] R13: 00007ffdd38c69ef R14: 00007fb7db3ad300 R15: 0000000000022000 [ 654.222625][ T27] [ 654.225695][ T27] INFO: task syz-executor.4:3792 can't die for more than 146 seconds. [ 654.237537][ T27] task:syz-executor.4 state:D stack:28504 pid: 3792 ppid: 3658 flags:0x00000004 [ 654.246948][ T27] Call Trace: [ 654.250286][ T27] [ 654.253339][ T27] __schedule+0xab2/0x4e90 [ 654.257794][ T27] ? io_schedule_timeout+0x180/0x180 [ 654.263228][ T27] schedule+0xd2/0x260 [ 654.267332][ T27] schedule_preempt_disabled+0xf/0x20 [ 654.272846][ T27] __mutex_lock+0xa32/0x12f0 [ 654.277476][ T27] ? usbdev_open+0x19d/0x920 [ 654.282148][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 654.287804][ T27] ? device_match_of_node+0x50/0x50 [ 654.294044][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 654.299644][ T27] usbdev_open+0x19d/0x920 [ 654.304199][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 654.310495][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 654.316888][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 654.322674][ T27] ? async_completed+0xad0/0xad0 [ 654.327633][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.332724][ T27] ? async_completed+0xad0/0xad0 [ 654.337686][ T27] chrdev_open+0x266/0x770 [ 654.342677][ T27] ? cdev_device_add+0x210/0x210 [ 654.347735][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 654.357621][ T27] do_dentry_open+0x4b9/0x1240 [ 654.364185][ T27] ? cdev_device_add+0x210/0x210 [ 654.369145][ T27] ? may_open+0x1f6/0x420 [ 654.377641][ T27] path_openat+0x1c9e/0x2940 [ 654.382586][ T27] ? path_lookupat+0x860/0x860 [ 654.387387][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 654.393750][ T27] do_filp_open+0x1aa/0x400 [ 654.398679][ T27] ? may_open_dev+0xf0/0xf0 [ 654.403275][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.408248][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 654.415353][ T27] ? _find_next_bit+0x1e3/0x260 [ 654.420302][ T27] ? _raw_spin_unlock+0x24/0x40 [ 654.425281][ T27] ? alloc_fd+0x2f0/0x670 [ 654.429645][ T27] do_sys_openat2+0x16d/0x4d0 [ 654.434411][ T27] ? build_open_flags+0x6f0/0x6f0 [ 654.439461][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 654.444968][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.449866][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.454872][ T27] __x64_sys_openat+0x13f/0x1f0 [ 654.459759][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 654.464817][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 654.470759][ T27] do_syscall_64+0x35/0xb0 [ 654.476260][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 654.482368][ T27] RIP: 0033:0x7f2ad26daf04 [ 654.486801][ T27] RSP: 002b:00007f2ad1e9cca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 654.495321][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f2ad26daf04 [ 654.503652][ T27] RDX: 0000000000028101 RSI: 00007f2ad1e9cd40 RDI: 00000000ffffff9c [ 654.511768][ T27] RBP: 00007f2ad1e9cd40 R08: 0000000000000000 R09: 0000000000000000 [ 654.519753][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 654.528058][ T27] R13: 00007ffd4db79f0f R14: 00007f2ad1e9d300 R15: 0000000000022000 [ 654.539037][ T27] [ 654.542596][ T27] INFO: task syz-executor.4:3792 blocked for more than 146 seconds. [ 654.550646][ T27] Not tainted 5.16.0-next-20220118-syzkaller #0 [ 654.559337][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 654.571573][ T27] task:syz-executor.4 state:D stack:28504 pid: 3792 ppid: 3658 flags:0x00000004 [ 654.580822][ T27] Call Trace: [ 654.585502][ T27] [ 654.588476][ T27] __schedule+0xab2/0x4e90 [ 654.593048][ T27] ? io_schedule_timeout+0x180/0x180 [ 654.598382][ T27] schedule+0xd2/0x260 [ 654.602992][ T27] schedule_preempt_disabled+0xf/0x20 [ 654.608404][ T27] __mutex_lock+0xa32/0x12f0 [ 654.613129][ T27] ? usbdev_open+0x19d/0x920 [ 654.617738][ T27] ? mutex_lock_io_nested+0x1150/0x1150 [ 654.623754][ T27] ? device_match_of_node+0x50/0x50 [ 654.629003][ T27] ? rcu_read_lock_sched_held+0x3a/0x70 [ 654.634995][ T27] usbdev_open+0x19d/0x920 [ 654.639447][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 654.649361][ T27] ? __sanitizer_cov_trace_const_cmp4+0x1c/0x70 [ 654.656647][ T27] ? kobject_get_unless_zero+0x15a/0x1e0 [ 654.665811][ T27] ? async_completed+0xad0/0xad0 [ 654.670753][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.677895][ T27] ? async_completed+0xad0/0xad0 [ 654.686856][ T27] chrdev_open+0x266/0x770 [ 654.692658][ T27] ? cdev_device_add+0x210/0x210 [ 654.697608][ T27] ? fsnotify_perm.part.0+0x22d/0x620 [ 654.704508][ T27] do_dentry_open+0x4b9/0x1240 [ 654.709316][ T27] ? cdev_device_add+0x210/0x210 [ 654.715025][ T27] ? may_open+0x1f6/0x420 [ 654.719411][ T27] path_openat+0x1c9e/0x2940 [ 654.724292][ T27] ? path_lookupat+0x860/0x860 [ 654.729070][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 654.735406][ T27] do_filp_open+0x1aa/0x400 [ 654.739917][ T27] ? may_open_dev+0xf0/0xf0 [ 654.744797][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 654.749781][ T27] ? __sanitizer_cov_trace_const_cmp8+0x1d/0x70 [ 654.756822][ T27] ? _find_next_bit+0x1e3/0x260 [ 654.762006][ T27] ? _raw_spin_unlock+0x24/0x40 [ 654.766893][ T27] ? alloc_fd+0x2f0/0x670 [ 654.771761][ T27] do_sys_openat2+0x16d/0x4d0 [ 654.776474][ T27] ? build_open_flags+0x6f0/0x6f0 [ 654.782859][ T27] ? __context_tracking_exit+0xb8/0xe0 [ 654.788374][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.793624][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 654.798524][ T27] __x64_sys_openat+0x13f/0x1f0 [ 654.804501][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 654.809485][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 654.815663][ T27] do_syscall_64+0x35/0xb0 [ 654.820115][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 654.826476][ T27] RIP: 0033:0x7f2ad26daf04 [ 654.830924][ T27] RSP: 002b:00007f2ad1e9cca0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 654.839519][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 00007f2ad26daf04 [ 654.847640][ T27] RDX: 0000000000028101 RSI: 00007f2ad1e9cd40 RDI: 00000000ffffff9c [ 654.856021][ T27] RBP: 00007f2ad1e9cd40 R08: 0000000000000000 R09: 0000000000000000 [ 654.864412][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000028101 [ 654.877299][ T27] R13: 00007ffd4db79f0f R14: 00007f2ad1e9d300 R15: 0000000000022000 [ 654.885526][ T27] [ 654.888564][ T27] [ 654.888564][ T27] Showing all locks held in the system: [ 654.901707][ T27] 1 lock held by khungtaskd/27: [ 654.907565][ T27] #0: ffffffff8bb83520 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 [ 654.917858][ T27] 2 locks held by getty/3291: [ 654.922642][ T27] #0: ffff88814aeb3098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 [ 654.932526][ T27] #1: ffffc90002b632e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xcf0/0x1230 [ 654.942818][ T27] 5 locks held by kworker/1:6/3709: [ 654.948023][ T27] #0: ffff888013392938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 [ 654.958788][ T27] #1: ffffc90002c7fda8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 [ 654.970169][ T27] #2: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c5/0x44d0 [ 654.979218][ T27] #3: ffff88801dc55580 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x1fba/0x44d0 [ 654.989272][ T27] #4: ffff88801d301868 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x1fe3/0x44d0 [ 654.999081][ T27] 1 lock held by syz-executor.0/3767: [ 655.005708][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x83/0x4b0 [ 655.016594][ T27] 1 lock held by syz-executor.2/3773: [ 655.022129][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_open+0x19d/0x920 [ 655.031191][ T27] 1 lock held by syz-executor.3/3778: [ 655.036577][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_open+0x19d/0x920 [ 655.045659][ T27] 1 lock held by syz-executor.5/3783: [ 655.051158][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_open+0x19d/0x920 [ 655.060125][ T27] 1 lock held by syz-executor.1/3790: [ 655.065567][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_open+0x19d/0x920 [ 655.074592][ T27] 1 lock held by syz-executor.4/3792: [ 655.079956][ T27] #0: ffff88801dc51220 (&dev->mutex){....}-{3:3}, at: usbdev_open+0x19d/0x920 [ 655.088997][ T27] [ 655.091394][ T27] ============================================= [ 655.091394][ T27] [ 655.099810][ T27] NMI backtrace for cpu 1 [ 655.104138][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.16.0-next-20220118-syzkaller #0 [ 655.113158][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 655.123209][ T27] Call Trace: [ 655.126499][ T27] [ 655.129450][ T27] dump_stack_lvl+0xcd/0x134 [ 655.134151][ T27] nmi_cpu_backtrace.cold+0x47/0x144 [ 655.139456][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 655.144706][ T27] nmi_trigger_cpumask_backtrace+0x1b3/0x230 [ 655.150739][ T27] watchdog+0xcb7/0xed0 [ 655.154917][ T27] ? trace_sched_process_hang+0x280/0x280 [ 655.160650][ T27] kthread+0x2e9/0x3a0 [ 655.164731][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 655.170384][ T27] ret_from_fork+0x1f/0x30 [ 655.174821][ T27] [ 655.178700][ T27] Sending NMI from CPU 1 to CPUs 0: [ 655.184250][ C0] NMI backtrace for cpu 0 [ 655.184261][ C0] CPU: 0 PID: 3269 Comm: kworker/0:3 Not tainted 5.16.0-next-20220118-syzkaller #0 [ 655.184285][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 655.184298][ C0] Workqueue: events nsim_dev_trap_report_work [ 655.184453][ C0] RIP: 0010:mark_lock+0x30/0x17b0 [ 655.184487][ C0] Code: 41 54 41 89 d4 48 ba 00 00 00 00 00 fc ff df 55 53 48 81 ec 18 01 00 00 48 8d 5c 24 38 48 89 3c 24 48 c7 44 24 38 b3 8a b5 41 <48> c1 eb 03 48 c7 44 24 40 28 3c 3a 8b 48 8d 04 13 48 c7 44 24 48 [ 655.184507][ C0] RSP: 0018:ffffc90002c9f938 EFLAGS: 00000092 [ 655.184523][ C0] RAX: 0000000000000004 RBX: ffffc90002c9f970 RCX: 1ffffffff1ffb5ee [ 655.184538][ C0] RDX: dffffc0000000000 RSI: ffff8880206c8a90 RDI: ffff8880206c8000 [ 655.184552][ C0] RBP: 0000000000000006 R08: 0000000000000000 R09: ffffffff8ffd2957 [ 655.184565][ C0] R10: 0000000000000001 R11: 0000000000088078 R12: 0000000000000006 [ 655.184578][ C0] R13: dffffc0000000000 R14: ffff8880206c8a68 R15: ffff888077ad2000 [ 655.184593][ C0] FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000 [ 655.184614][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 655.184628][ C0] CR2: 00007fac04558600 CR3: 000000000b88e000 CR4: 00000000003506f0 [ 655.184642][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 655.184654][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 655.184667][ C0] Call Trace: [ 655.184673][ C0] [ 655.184682][ C0] ? lock_chain_count+0x20/0x20 [ 655.184715][ C0] ? debug_check_no_obj_freed+0x20c/0x420 [ 655.184775][ C0] ? mark_held_locks+0x9f/0xe0 [ 655.184808][ C0] mark_held_locks+0x9f/0xe0 [ 655.184840][ C0] lockdep_hardirqs_on_prepare+0x28b/0x400 [ 655.184872][ C0] ? kasan_quarantine_put+0xf5/0x210 [ 655.184903][ C0] trace_hardirqs_on+0x5b/0x1c0 [ 655.184955][ C0] kasan_quarantine_put+0xf5/0x210 [ 655.184986][ C0] slab_free_freelist_hook+0x8b/0x1c0 [ 655.185040][ C0] ? skb_release_data+0x718/0x870 [ 655.185137][ C0] kfree+0xce/0x380 [ 655.185171][ C0] ? nsim_dev_trap_report_work+0x855/0xbc0 [ 655.185207][ C0] skb_release_data+0x718/0x870 [ 655.185240][ C0] consume_skb+0xc2/0x160 [ 655.185269][ C0] nsim_dev_trap_report_work+0x85d/0xbc0 [ 655.185308][ C0] process_one_work+0x996/0x1610 [ 655.185335][ C0] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 655.185361][ C0] ? rwlock_bug.part.0+0x90/0x90 [ 655.185395][ C0] ? _raw_spin_lock_irq+0x41/0x50 [ 655.185434][ C0] worker_thread+0x665/0x1080 [ 655.185462][ C0] ? __kthread_parkme+0x15f/0x220 [ 655.185495][ C0] ? process_one_work+0x1610/0x1610 [ 655.185520][ C0] kthread+0x2e9/0x3a0 [ 655.185553][ C0] ? kthread_complete_and_exit+0x40/0x40 [ 655.185592][ C0] ret_from_fork+0x1f/0x30 [ 655.185627][ C0] [ 655.186943][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 655.468193][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.16.0-next-20220118-syzkaller #0 [ 655.477466][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 655.487712][ T27] Call Trace: [ 655.490998][ T27] [ 655.493923][ T27] dump_stack_lvl+0xcd/0x134 [ 655.498639][ T27] panic+0x2b0/0x605 [ 655.502569][ T27] ? __warn_printk+0xf3/0xf3 [ 655.507157][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 655.512375][ T27] ? preempt_schedule_thunk+0x16/0x18 [ 655.517773][ T27] ? nmi_trigger_cpumask_backtrace+0x196/0x230 [ 655.523953][ T27] ? watchdog.cold+0x1b9/0x1de [ 655.528748][ T27] watchdog.cold+0x1ca/0x1de [ 655.533343][ T27] ? trace_sched_process_hang+0x280/0x280 [ 655.539117][ T27] kthread+0x2e9/0x3a0 [ 655.543185][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 655.548816][ T27] ret_from_fork+0x1f/0x30 [ 655.553247][ T27] [ 655.556722][ T27] Kernel Offset: disabled [ 655.561054][ T27] Rebooting in 86400 seconds..