[ 56.601896][ T26] audit: type=1400 audit(1675028536.788:82): avc: denied { setattr } for pid=5065 comm="syz-executor" name="raw-gadget" dev="devtmpfs" ino=732 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:device_t tclass=chr_file permissive=1 [ 56.770480][ T26] audit: type=1400 audit(1675028537.068:83): avc: denied { execmem } for pid=5066 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=process permissive=1 [ 56.858443][ T26] audit: type=1400 audit(1675028537.158:84): avc: denied { mounton } for pid=5067 comm="syz-executor.0" path="/sys/fs/fuse/connections" dev="fusectl" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fusefs_t tclass=dir permissive=1 [ 59.154651][ T5063] can: request_module (can-proto-0) failed. [ 59.184787][ T5063] can: request_module (can-proto-0) failed. [ 59.212986][ T5063] can: request_module (can-proto-0) failed. [ 65.260358][ T26] kauditd_printk_skb: 81 callbacks suppressed [ 65.260374][ T26] audit: type=1400 audit(1675028545.568:166): avc: denied { append } for pid=4403 comm="syslogd" name="messages" dev="tmpfs" ino=3 scontext=system_u:system_r:syslogd_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 65.288732][ T26] audit: type=1400 audit(1675028545.568:167): avc: denied { open } for pid=4403 comm="syslogd" path="/tmp/messages" dev="tmpfs" ino=3 scontext=system_u:system_r:syslogd_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 65.311290][ T26] audit: type=1400 audit(1675028545.568:168): avc: denied { getattr } for pid=4403 comm="syslogd" path="/tmp/messages" dev="tmpfs" ino=3 scontext=system_u:system_r:syslogd_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 76.052332][ T6] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.1.125' (ECDSA) to the list of known hosts. 2023/01/29 21:42:40 parsed 1 programs [ 79.835640][ T26] audit: type=1400 audit(1675028560.138:169): avc: denied { mounton } for pid=5137 comm="syz-executor" path="/proc/sys/fs/binfmt_misc" dev="binfmt_misc" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:binfmt_misc_fs_t tclass=dir permissive=1 [ 79.861052][ T26] audit: type=1400 audit(1675028560.138:170): avc: denied { mount } for pid=5137 comm="syz-executor" name="/" dev="binfmt_misc" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:binfmt_misc_fs_t tclass=filesystem permissive=1 2023/01/29 21:42:40 executed programs: 0 [ 80.081416][ T26] audit: type=1400 audit(1675028560.388:171): avc: denied { mount } for pid=5141 comm="syz-executor.0" name="/" dev="fusectl" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fusefs_t tclass=filesystem permissive=1 [ 80.120598][ T26] audit: type=1400 audit(1675028560.388:172): avc: denied { mounton } for pid=5141 comm="syz-executor.0" path="/syzcgroup/unified" dev="sda1" ino=1142 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:root_t tclass=dir permissive=1 [ 80.168166][ T26] audit: type=1400 audit(1675028560.388:173): avc: denied { mount } for pid=5141 comm="syz-executor.0" name="/" dev="cgroup2" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cgroup_t tclass=filesystem permissive=1 [ 81.258857][ T5142] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 81.259054][ T26] audit: type=1400 audit(1675028561.558:174): avc: denied { ioctl } for pid=5141 comm="syz-executor.0" path="socket:[29875]" dev="sockfs" ino=29875 ioctlcmd=0x48c9 scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=bluetooth_socket permissive=1 [ 81.267240][ T5142] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 81.299202][ T5142] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 81.307414][ T5142] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 81.315190][ T5142] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 81.322592][ T5142] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 81.399775][ T5141] chnl_net:caif_netlink_parms(): no params data found [ 81.438616][ T5141] bridge0: port 1(bridge_slave_0) entered blocking state [ 81.446421][ T5141] bridge0: port 1(bridge_slave_0) entered disabled state [ 81.454360][ T5141] device bridge_slave_0 entered promiscuous mode [ 81.463224][ T5141] bridge0: port 2(bridge_slave_1) entered blocking state [ 81.470595][ T5141] bridge0: port 2(bridge_slave_1) entered disabled state [ 81.478478][ T5141] device bridge_slave_1 entered promiscuous mode [ 81.498688][ T5141] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 81.509490][ T5141] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 81.531090][ T5141] team0: Port device team_slave_0 added [ 81.537919][ T5141] team0: Port device team_slave_1 added [ 81.554897][ T5141] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 81.562010][ T5141] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 81.587968][ T5141] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 81.600203][ T5141] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 81.607214][ T5141] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 81.633206][ T5141] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 81.656857][ T5141] device hsr_slave_0 entered promiscuous mode [ 81.663931][ T5141] device hsr_slave_1 entered promiscuous mode [ 81.748621][ T26] audit: type=1400 audit(1675028562.048:175): avc: denied { create } for pid=5141 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 81.750338][ T5141] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 81.769494][ T26] audit: type=1400 audit(1675028562.048:176): avc: denied { write } for pid=5141 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 81.769535][ T26] audit: type=1400 audit(1675028562.048:177): avc: denied { read } for pid=5141 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 81.822474][ T5141] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 81.832733][ T5141] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 81.841962][ T5141] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 81.861459][ T5141] bridge0: port 2(bridge_slave_1) entered blocking state [ 81.868584][ T5141] bridge0: port 2(bridge_slave_1) entered forwarding state [ 81.876396][ T5141] bridge0: port 1(bridge_slave_0) entered blocking state [ 81.883479][ T5141] bridge0: port 1(bridge_slave_0) entered forwarding state [ 81.923463][ T5141] 8021q: adding VLAN 0 to HW filter on device bond0 [ 81.937431][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 81.947427][ T896] bridge0: port 1(bridge_slave_0) entered disabled state [ 81.956108][ T896] bridge0: port 2(bridge_slave_1) entered disabled state [ 81.963949][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 81.976733][ T5141] 8021q: adding VLAN 0 to HW filter on device team0 [ 81.987069][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 81.995586][ T896] bridge0: port 1(bridge_slave_0) entered blocking state [ 82.002770][ T896] bridge0: port 1(bridge_slave_0) entered forwarding state [ 82.022845][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 82.031664][ T896] bridge0: port 2(bridge_slave_1) entered blocking state [ 82.038749][ T896] bridge0: port 2(bridge_slave_1) entered forwarding state [ 82.047515][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 82.063448][ T5141] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 82.075824][ T5141] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 82.088261][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 82.097829][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 82.106357][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 82.115060][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 82.123678][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 82.144201][ T5141] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 82.151673][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 82.159263][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 82.196181][ T26] audit: type=1400 audit(1675028562.498:178): avc: denied { sys_module } for pid=5141 comm="syz-executor.0" capability=16 scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=capability permissive=1 [ 82.331373][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 82.340058][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 82.349076][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 82.357681][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 82.366724][ T5141] device veth0_vlan entered promiscuous mode [ 82.381802][ T5141] device veth1_vlan entered promiscuous mode [ 82.399485][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 82.408854][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 82.417110][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 82.428531][ T5141] device veth0_macvtap entered promiscuous mode [ 82.439736][ T5141] device veth1_macvtap entered promiscuous mode [ 82.464721][ T5141] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 82.472507][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 82.482759][ T5149] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 82.494473][ T5141] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 82.502608][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 82.511785][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 82.521982][ T5141] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 82.531444][ T5141] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 82.540307][ T5141] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 82.549543][ T5141] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 82.717657][ T5159] nbd0: detected capacity change from 0 to 10 [ 83.412017][ T4375] Bluetooth: hci0: command 0x0409 tx timeout [ 83.436824][ T5142] block nbd0: Receive control failed (result -104) [ 85.490788][ T5142] Bluetooth: hci0: command 0x041b tx timeout [ 87.571061][ T5142] Bluetooth: hci0: command 0x040f tx timeout [ 89.660751][ T5142] Bluetooth: hci0: command 0x0419 tx timeout [ 113.172772][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 30 seconds [ 143.251325][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 60 seconds [ 144.138516][ T4421] udevd[4421]: worker [5129] /devices/virtual/block/nbd0 is taking a long time [ 173.331010][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 90 seconds [ 203.411413][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 120 seconds [ 206.130846][ T5142] Bluetooth: hci0: command 0x0406 tx timeout [ 233.495517][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 150 seconds [ 263.571094][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 180 seconds [ 264.418730][ T4421] udevd[4421]: worker [5129] /devices/virtual/block/nbd0 timeout; kill it [ 264.427645][ T4421] udevd[4421]: seq 7900 '/devices/virtual/block/nbd0' killed [ 264.427685][ T5129] ldm_validate_partition_table(): Disk read failed. [ 264.442452][ T5129] Dev nbd0: unable to read RDB block 0 [ 264.447933][ T5129] nbd0: unable to read partition table [ 264.453676][ T5129] nbd0: partition table beyond EOD, truncated 2023/01/29 21:45:44 executed programs: 1 2023/01/29 21:45:45 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe [ 264.705428][ T26] audit: type=1400 audit(1675028745.008:179): avc: denied { mounton } for pid=5176 comm="syz-executor.0" path="/syzcgroup/unified" dev="cgroup2" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cgroup_t tclass=dir permissive=1 2023/01/29 21:45:48 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe wrong response packet (errno 16) loop exited with status 67 [ 267.810780][ T4375] Bluetooth: hci0: Opcode 0x c03 failed: -110 2023/01/29 21:45:51 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe wrong response packet (errno 16) loop exited with status 67 2023/01/29 21:45:51 executed programs: 4 [ 270.930780][ T4375] Bluetooth: hci0: Opcode 0x c03 failed: -110 2023/01/29 21:45:54 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe wrong response packet (errno 16) loop exited with status 67 [ 274.050745][ T4375] Bluetooth: hci0: Opcode 0x c03 failed: -110 [ 275.102236][ T5142] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 275.110048][ T5142] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 275.118044][ T5142] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 275.126452][ T47] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 275.134675][ T47] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 275.142046][ T47] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 275.213977][ T5182] chnl_net:caif_netlink_parms(): no params data found [ 275.250193][ T5182] bridge0: port 1(bridge_slave_0) entered blocking state [ 275.257441][ T5182] bridge0: port 1(bridge_slave_0) entered disabled state [ 275.265332][ T5182] device bridge_slave_0 entered promiscuous mode [ 275.273109][ T5182] bridge0: port 2(bridge_slave_1) entered blocking state [ 275.280348][ T5182] bridge0: port 2(bridge_slave_1) entered disabled state [ 275.288896][ T5182] device bridge_slave_1 entered promiscuous mode [ 275.308288][ T5182] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 275.319114][ T5182] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 275.340128][ T5182] team0: Port device team_slave_0 added [ 275.347324][ T5182] team0: Port device team_slave_1 added [ 275.363175][ T5182] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 275.370219][ T5182] 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. [ 275.396648][ T5182] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 275.408263][ T5182] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 275.415456][ T5182] 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. [ 275.442971][ T5182] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 275.468548][ T5182] device hsr_slave_0 entered promiscuous mode [ 275.475235][ T5182] device hsr_slave_1 entered promiscuous mode [ 275.482946][ T5182] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 275.490819][ T5182] Cannot create hsr debugfs directory [ 275.545154][ T5182] bridge0: port 2(bridge_slave_1) entered blocking state [ 275.552235][ T5182] bridge0: port 2(bridge_slave_1) entered forwarding state [ 275.559518][ T5182] bridge0: port 1(bridge_slave_0) entered blocking state [ 275.566925][ T5182] bridge0: port 1(bridge_slave_0) entered forwarding state [ 275.603630][ T5182] 8021q: adding VLAN 0 to HW filter on device bond0 [ 275.615018][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 275.623429][ T896] bridge0: port 1(bridge_slave_0) entered disabled state [ 275.631111][ T896] bridge0: port 2(bridge_slave_1) entered disabled state [ 275.638821][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 275.649732][ T5182] 8021q: adding VLAN 0 to HW filter on device team0 [ 275.672716][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 275.681616][ T896] bridge0: port 1(bridge_slave_0) entered blocking state [ 275.688667][ T896] bridge0: port 1(bridge_slave_0) entered forwarding state [ 275.696924][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 275.705789][ T896] bridge0: port 2(bridge_slave_1) entered blocking state [ 275.712868][ T896] bridge0: port 2(bridge_slave_1) entered forwarding state [ 275.721462][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 275.729854][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 275.739244][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 275.750113][ T6] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 275.761322][ T5182] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 275.773697][ T5182] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 275.783153][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 275.801004][ T5182] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 275.808328][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 275.816204][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 276.119824][ T5182] device veth0_vlan entered promiscuous mode [ 276.128716][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 276.137857][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 276.146303][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 276.154747][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 276.166616][ T5182] device veth1_vlan entered promiscuous mode [ 276.183670][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 276.191975][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 276.200418][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 276.211475][ T5182] device veth0_macvtap entered promiscuous mode [ 276.221298][ T5182] device veth1_macvtap entered promiscuous mode [ 276.229972][ T4383] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 276.245845][ T5182] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 276.256516][ T5182] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 276.267357][ T5182] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 276.274695][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 276.283837][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 276.294274][ T5182] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 276.306241][ T5182] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 276.316988][ T5182] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 276.328224][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 276.336734][ T896] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 277.171436][ T4375] Bluetooth: hci0: command 0x0409 tx timeout [ 279.251104][ T4375] Bluetooth: hci0: command 0x041b tx timeout [ 281.341076][ T4375] Bluetooth: hci0: command 0x040f tx timeout [ 283.410755][ T4375] Bluetooth: hci0: command 0x0419 tx timeout [ 293.650848][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 210 seconds [ 323.730844][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 240 seconds [ 353.810913][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 270 seconds [ 383.890817][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 300 seconds [ 400.690650][ T47] Bluetooth: hci0: command 0x0406 tx timeout [ 413.971622][ T51] block nbd0: Possible stuck request ffff88801fd60000: control (read@0,4096B). Runtime 330 seconds [ 429.330695][ T27] INFO: task udevd:5129 blocked for more than 143 seconds. [ 429.338094][ T27] Not tainted 6.2.0-rc5-syzkaller-00221-gab072681eabe #0 [ 429.347252][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 429.356009][ T27] task:udevd state:D stack:26304 pid:5129 ppid:4421 flags:0x00004006 [ 429.365586][ T27] Call Trace: [ 429.368879][ T27] [ 429.371871][ T27] __schedule+0xb8a/0x5450 [ 429.376811][ T27] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 429.382878][ T27] ? lock_chain_count+0x20/0x20 [ 429.387923][ T27] ? lock_chain_count+0x20/0x20 [ 429.392821][ T27] ? io_schedule_timeout+0x150/0x150 [ 429.398235][ T27] ? mark_held_locks+0x9f/0xe0 [ 429.403039][ T27] schedule+0xde/0x1b0 [ 429.407124][ T27] io_schedule+0xbe/0x130 [ 429.411876][ T27] folio_wait_bit_common+0x394/0x9b0 [ 429.417247][ T27] ? filemap_range_has_writeback+0x650/0x650 [ 429.424833][ T27] ? __filemap_get_folio+0x254/0xd80 [ 429.430154][ T27] ? folio_unlock+0xd0/0xd0 [ 429.434767][ T27] __filemap_get_folio+0xb71/0xd80 [ 429.439891][ T27] ? filemap_add_folio+0x1e0/0x1e0 [ 429.445167][ T27] ? filemap_get_folios+0x700/0x700 [ 429.450402][ T27] truncate_inode_pages_range+0x350/0xec0 [ 429.456236][ T27] ? truncate_inode_partial_folio+0xb90/0xb90 [ 429.462411][ T27] ? _find_next_bit+0x11b/0x140 [ 429.467352][ T27] ? smp_call_function_many_cond+0x47f/0x10a0 [ 429.473526][ T27] ? __brelse+0xa0/0xa0 [ 429.477717][ T27] ? smp_call_on_cpu+0x250/0x250 [ 429.482758][ T27] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 429.488328][ T27] ? __brelse+0xa0/0xa0 [ 429.492555][ T27] blkdev_flush_mapping+0x140/0x2f0 [ 429.497826][ T27] blkdev_put_whole+0xd1/0xf0 [ 429.502633][ T27] blkdev_put+0x22a/0x770 [ 429.506984][ T27] blkdev_close+0x68/0x80 [ 429.511376][ T27] __fput+0x27c/0xa90 [ 429.515436][ T27] ? blkdev_fsync+0xa0/0xa0 [ 429.519926][ T27] task_work_run+0x16f/0x270 [ 429.524612][ T27] ? task_work_cancel+0x30/0x30 [ 429.529483][ T27] ? do_raw_spin_unlock+0x175/0x230 [ 429.534712][ T27] do_exit+0xaa8/0x2950 [ 429.538887][ T27] ? find_held_lock+0x2d/0x110 [ 429.543763][ T27] ? get_signal+0x8a0/0x2450 [ 429.548371][ T27] ? mm_update_next_owner+0x7b0/0x7b0 [ 429.553807][ T27] do_group_exit+0xd4/0x2a0 [ 429.558329][ T27] get_signal+0x21c3/0x2450 [ 429.562921][ T27] ? exit_signals+0x8b0/0x8b0 [ 429.567607][ T27] ? do_sys_openat2+0xa1/0x4c0 [ 429.572405][ T27] arch_do_signal_or_restart+0x79/0x5c0 [ 429.577960][ T27] ? get_sigframe_size+0x10/0x10 [ 429.583444][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 429.588409][ T27] exit_to_user_mode_prepare+0x15f/0x250 [ 429.594179][ T27] syscall_exit_to_user_mode+0x1d/0x50 [ 429.599674][ T27] do_syscall_64+0x46/0xb0 [ 429.604206][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 429.610189][ T27] RIP: 0033:0x7fba7ef25697 [ 429.614638][ T27] RSP: 002b:00007ffe32d172a0 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 [ 429.623140][ T27] RAX: 0000000000000008 RBX: 0000556e7bad69d0 RCX: 00007fba7ef25697 [ 429.631148][ T27] RDX: 00000000000a0800 RSI: 0000556e7bac4c90 RDI: 00000000ffffff9c [ 429.639125][ T27] RBP: 0000556e7bac4c90 R08: 0000000000000001 R09: 00007ffe32dd4080 [ 429.647272][ T27] R10: 0000000000000000 R11: 0000000000000246 R12: 00000000000a0800 [ 429.655287][ T27] R13: 0000556e7bae32b0 R14: 0000000000000001 R15: 0000556e7ba9b2c0 [ 429.663465][ T27] [ 429.666550][ T27] INFO: task syz-executor.0:5203 blocked for more than 143 seconds. [ 429.675975][ T27] Not tainted 6.2.0-rc5-syzkaller-00221-gab072681eabe #0 [ 429.683755][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 429.693780][ T27] task:syz-executor.0 state:D stack:27952 pid:5203 ppid:5182 flags:0x00000004 [ 429.704052][ T27] Call Trace: [ 429.707334][ T27] [ 429.710251][ T27] __schedule+0xb8a/0x5450 [ 429.716194][ T27] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 429.722316][ T27] ? io_schedule_timeout+0x150/0x150 [ 429.727598][ T27] ? __mutex_lock+0xa43/0x1360 [ 429.733730][ T27] schedule+0xde/0x1b0 [ 429.737787][ T27] schedule_preempt_disabled+0x13/0x20 [ 429.743413][ T27] __mutex_lock+0xa48/0x1360 [ 429.747991][ T27] ? blkdev_get_by_dev.part.0+0x9b/0xb90 [ 429.754966][ T27] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 429.760543][ T27] ? _atomic_dec_and_lock+0x96/0x100 [ 429.765895][ T27] ? disk_block_events+0x21/0x140 [ 429.771140][ T27] blkdev_get_by_dev.part.0+0x9b/0xb90 [ 429.776632][ T27] ? devcgroup_check_permission+0x1aa/0x440 [ 429.782996][ T27] blkdev_get_by_dev+0x6f/0x90 [ 429.787764][ T27] blkdev_open+0x140/0x2c0 [ 429.792498][ T27] do_dentry_open+0x6cc/0x13f0 [ 429.797459][ T27] ? blkdev_close+0x80/0x80 [ 429.802391][ T27] path_openat+0x1bbc/0x2a50 [ 429.807115][ T27] ? path_lookupat+0x840/0x840 [ 429.812202][ T27] do_filp_open+0x1ba/0x410 [ 429.816731][ T27] ? may_open_dev+0xf0/0xf0 [ 429.821794][ T27] ? find_held_lock+0x2d/0x110 [ 429.826587][ T27] ? do_raw_spin_lock+0x124/0x2b0 [ 429.831723][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 429.836675][ T27] ? _raw_spin_unlock+0x28/0x40 [ 429.841769][ T27] ? alloc_fd+0x2d8/0x6d0 [ 429.846151][ T27] do_sys_openat2+0x16d/0x4c0 [ 429.851015][ T27] ? build_open_flags+0x6f0/0x6f0 [ 429.856038][ T27] ? up_write+0x520/0x520 [ 429.860353][ T27] __x64_sys_openat+0x143/0x1f0 [ 429.865464][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 429.870390][ T27] ? syscall_enter_from_user_mode+0x26/0xb0 [ 429.876466][ T27] do_syscall_64+0x39/0xb0 [ 429.881139][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 429.887049][ T27] RIP: 0033:0x418484 [ 429.891238][ T27] RSP: 002b:00007ff6e14bccc0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 429.899752][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 0000000000418484 [ 429.907934][ T27] RDX: 0000000000000000 RSI: 00007ff6e14bcd60 RDI: 00000000ffffff9c [ 429.916037][ T27] RBP: 00007ff6e14bcd60 R08: 0000000000000000 R09: 002364626e2f7665 [ 429.924163][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000 [ 429.932361][ T27] R13: 00007ffe432eb43f R14: 00007ff6e14bd300 R15: 0000000000022000 [ 429.940361][ T27] [ 429.943549][ T27] [ 429.943549][ T27] Showing all locks held in the system: [ 429.951334][ T27] 1 lock held by rcu_tasks_kthre/11: [ 429.956610][ T27] #0: ffffffff8c78dff0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 [ 429.967171][ T27] 1 lock held by rcu_tasks_trace/12: [ 429.972813][ T27] #0: ffffffff8c78dcf0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 [ 429.983973][ T27] 1 lock held by khungtaskd/27: [ 429.988837][ T27] #0: ffffffff8c78eb40 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x57/0x264 [ 429.998790][ T27] 1 lock held by klogd/4410: [ 430.003426][ T27] #0: ffff8880b983b5d8 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2f/0x120 [ 430.013404][ T27] 2 locks held by getty/4742: [ 430.018089][ T27] #0: ffff88814b0ba098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x26/0x80 [ 430.028933][ T27] #1: ffffc900020382f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xef4/0x13e0 [ 430.039282][ T27] 1 lock held by udevd/5129: [ 430.043903][ T27] #0: ffff888146b3c4c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xc0/0x770 [ 430.053460][ T27] 1 lock held by syz-executor.0/5203: [ 430.058902][ T27] #0: ffff888146b3c4c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb90 [ 430.069555][ T27] [ 430.071947][ T27] ============================================= [ 430.071947][ T27] [ 430.080683][ T27] NMI backtrace for cpu 1 [ 430.085013][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 6.2.0-rc5-syzkaller-00221-gab072681eabe #0 [ 430.094796][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023 [ 430.104843][ T27] Call Trace: [ 430.108105][ T27] [ 430.111023][ T27] dump_stack_lvl+0xd1/0x138 [ 430.115619][ T27] nmi_cpu_backtrace.cold+0x24/0x18a [ 430.120890][ T27] nmi_trigger_cpumask_backtrace+0x333/0x3c0 [ 430.126868][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 430.132058][ T27] watchdog+0xc75/0xfc0 [ 430.136256][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 430.142244][ T27] kthread+0x2e8/0x3a0 [ 430.146321][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 430.151937][ T27] ret_from_fork+0x1f/0x30 [ 430.156342][ T27] [ 430.159478][ T27] Sending NMI from CPU 1 to CPUs 0: [ 430.164740][ C0] NMI backtrace for cpu 0 skipped: idling at acpi_idle_do_entry+0x1fd/0x2a0 [ 430.165762][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 430.181226][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 6.2.0-rc5-syzkaller-00221-gab072681eabe #0 [ 430.191022][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023 [ 430.201056][ T27] Call Trace: [ 430.204317][ T27] [ 430.207228][ T27] dump_stack_lvl+0xd1/0x138 [ 430.211815][ T27] panic+0x2cc/0x626 [ 430.215697][ T27] ? panic_print_sys_info.part.0+0x110/0x110 [ 430.221670][ T27] ? preempt_schedule_thunk+0x1a/0x20 [ 430.227047][ T27] ? watchdog.cold+0x130/0x158 [ 430.231827][ T27] watchdog.cold+0x141/0x158 [ 430.236413][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 430.242396][ T27] kthread+0x2e8/0x3a0 [ 430.246458][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 430.252087][ T27] ret_from_fork+0x1f/0x30 [ 430.256504][ T27] [ 430.259674][ T27] Kernel Offset: disabled [ 430.264002][ T27] Rebooting in 86400 seconds..