tclass=chr_file permissive=1 [ 69.043072][ T26] audit: type=1400 audit(1683675113.701:90): avc: denied { execmem } for pid=4998 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=process permissive=1 [ 69.157602][ T26] audit: type=1400 audit(1683675113.811:91): avc: denied { mounton } for pid=4999 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 [ 69.189096][ T26] audit: type=1400 audit(1683675113.841:92): avc: denied { mount } for pid=4999 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 [ 71.748114][ T4986] can: request_module (can-proto-0) failed. [ 71.778284][ T4986] can: request_module (can-proto-0) failed. [ 71.803383][ T4986] can: request_module (can-proto-0) failed. [ 88.260455][ T1615] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.1.29' (ECDSA) to the list of known hosts. 2023/05/09 23:32:18 parsed 1 programs [ 93.455348][ T26] kauditd_printk_skb: 82 callbacks suppressed [ 93.455363][ T26] audit: type=1400 audit(1683675138.111:175): avc: denied { getattr } for pid=5064 comm="syz-execprog" path="user:[4026531837]" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 93.486040][ T26] audit: type=1400 audit(1683675138.111:176): avc: denied { read } for pid=5064 comm="syz-execprog" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 93.508428][ T26] audit: type=1400 audit(1683675138.111:177): avc: denied { open } for pid=5064 comm="syz-execprog" path="user:[4026531837]" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 93.533967][ T26] audit: type=1400 audit(1683675138.151:178): avc: denied { mounton } for pid=5069 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 [ 93.559412][ T26] audit: type=1400 audit(1683675138.151:179): avc: denied { mount } for pid=5069 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/05/09 23:32:18 executed programs: 0 [ 93.747025][ T26] audit: type=1400 audit(1683675138.401:180): avc: denied { mounton } for pid=5073 comm="syz-executor.0" path="/syzcgroup/unified" dev="sda1" ino=1931 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:root_t tclass=dir permissive=1 [ 93.770127][ T26] audit: type=1400 audit(1683675138.411:181): avc: denied { mount } for pid=5073 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 [ 93.874225][ T5073] chnl_net:caif_netlink_parms(): no params data found [ 93.917902][ T5073] bridge0: port 1(bridge_slave_0) entered blocking state [ 93.925597][ T5073] bridge0: port 1(bridge_slave_0) entered disabled state [ 93.932827][ T5073] bridge_slave_0: entered allmulticast mode [ 93.939556][ T5073] bridge_slave_0: entered promiscuous mode [ 93.950368][ T5073] bridge0: port 2(bridge_slave_1) entered blocking state [ 93.957463][ T5073] bridge0: port 2(bridge_slave_1) entered disabled state [ 93.964662][ T5073] bridge_slave_1: entered allmulticast mode [ 93.971239][ T5073] bridge_slave_1: entered promiscuous mode [ 93.992564][ T5073] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 94.003537][ T5073] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 94.027818][ T5073] team0: Port device team_slave_0 added [ 94.035199][ T5073] team0: Port device team_slave_1 added [ 94.053462][ T5073] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 94.060779][ T5073] 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. [ 94.086751][ T5073] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 94.099935][ T5073] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 94.106883][ T5073] 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. [ 94.133052][ T5073] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 94.160453][ T5073] hsr_slave_0: entered promiscuous mode [ 94.167131][ T5073] hsr_slave_1: entered promiscuous mode [ 94.256997][ T26] audit: type=1400 audit(1683675138.911:182): avc: denied { write } for pid=5073 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 94.260160][ T5073] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 94.277811][ T26] audit: type=1400 audit(1683675138.911:183): avc: denied { read } for pid=5073 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 94.307776][ T5073] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 94.317077][ T5073] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 94.326524][ T5073] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 94.350727][ T5073] bridge0: port 2(bridge_slave_1) entered blocking state [ 94.357900][ T5073] bridge0: port 2(bridge_slave_1) entered forwarding state [ 94.366013][ T5073] bridge0: port 1(bridge_slave_0) entered blocking state [ 94.373105][ T5073] bridge0: port 1(bridge_slave_0) entered forwarding state [ 94.418008][ T5073] 8021q: adding VLAN 0 to HW filter on device bond0 [ 94.430848][ T8] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 94.441674][ T8] bridge0: port 1(bridge_slave_0) entered disabled state [ 94.451413][ T8] bridge0: port 2(bridge_slave_1) entered disabled state [ 94.462044][ T8] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 94.474950][ T5073] 8021q: adding VLAN 0 to HW filter on device team0 [ 94.485017][ T5005] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 94.494188][ T5005] bridge0: port 1(bridge_slave_0) entered blocking state [ 94.501287][ T5005] bridge0: port 1(bridge_slave_0) entered forwarding state [ 94.512493][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 94.520904][ T5079] bridge0: port 2(bridge_slave_1) entered blocking state [ 94.527949][ T5079] bridge0: port 2(bridge_slave_1) entered forwarding state [ 94.550333][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 94.559382][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 94.567865][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 94.578563][ T5005] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 94.592997][ T5073] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 94.604591][ T5073] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 94.614308][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 94.630977][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 94.638376][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 94.650986][ T5073] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 94.689667][ T26] audit: type=1400 audit(1683675139.351:184): avc: denied { sys_module } for pid=5073 comm="syz-executor.0" capability=16 scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=capability permissive=1 [ 94.812901][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 94.831933][ T5073] veth0_vlan: entered promiscuous mode [ 94.839595][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 94.848092][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 94.856078][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 94.868814][ T5073] veth1_vlan: entered promiscuous mode [ 94.887960][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 94.897119][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 94.907762][ T5073] veth0_macvtap: entered promiscuous mode [ 94.922211][ T5073] veth1_macvtap: entered promiscuous mode [ 94.935549][ T5073] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 94.943214][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 94.951515][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 94.959690][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 94.968165][ T5079] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 94.981361][ T5073] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 94.989218][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 94.997733][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 95.009583][ T5073] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.018495][ T5073] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.027652][ T5073] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.036818][ T5073] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 95.206806][ T5089] nbd0: detected capacity change from 0 to 2176 [ 95.912786][ T47] block nbd0: Receive control failed (result -104) [ 95.918843][ T5090] block nbd0: shutting down sockets [ 95.925948][ C0] I/O error, dev nbd0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 [ 95.935200][ C0] Buffer I/O error on dev nbd0, logical block 0, async page read [ 95.943142][ T51] I/O error, dev nbd0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 [ 95.945819][ T5089] ldm_validate_partition_table(): Disk read failed. [ 95.952538][ T51] Buffer I/O error on dev nbd0, logical block 0, async page read [ 95.959739][ T5089] Dev nbd0: unable to read RDB block 0 [ 95.975663][ T5089] nbd0: unable to read partition table [ 95.981464][ T5089] nbd0: partition table beyond EOD, truncated [ 96.096568][ T5093] nbd0: detected capacity change from 0 to 2176 [ 96.809163][ T47] block nbd0: Receive control failed (result -104) [ 126.661037][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 30 seconds [ 156.361343][ T4445] udevd[4445]: worker [5061] /devices/virtual/block/nbd0 is taking a long time [ 156.739897][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 60 seconds [ 186.819000][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 90 seconds [ 216.899788][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 120 seconds [ 246.979156][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 150 seconds [ 276.736091][ T4445] udevd[4445]: worker [5061] /devices/virtual/block/nbd0 timeout; kill it [ 276.746682][ T4445] udevd[4445]: seq 7932 '/devices/virtual/block/nbd0' killed [ 276.746999][ T5061] ldm_validate_partition_table(): Disk read failed. [ 276.760787][ T5061] Dev nbd0: unable to read RDB block 0 [ 276.766245][ T5061] nbd0: unable to read partition table [ 276.772534][ T5061] nbd0: partition table beyond EOD, truncated 2023/05/09 23:35:21 executed programs: 2 2023/05/09 23:35:21 result: hanged=false err=executor 0: failed to write control pipe: write |1: broken pipe [ 277.054327][ T26] audit: type=1400 audit(1683675321.711:185): avc: denied { mounton } for pid=5109 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 [ 277.078225][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 180 seconds [ 277.079739][ T26] audit: type=1400 audit(1683675321.721:186): avc: denied { mount } for pid=5109 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 [ 277.160310][ T5109] chnl_net:caif_netlink_parms(): no params data found [ 277.203022][ T5109] bridge0: port 1(bridge_slave_0) entered blocking state [ 277.210253][ T5109] bridge0: port 1(bridge_slave_0) entered disabled state [ 277.217491][ T5109] bridge_slave_0: entered allmulticast mode [ 277.224966][ T5109] bridge_slave_0: entered promiscuous mode [ 277.232603][ T5109] bridge0: port 2(bridge_slave_1) entered blocking state [ 277.241441][ T5109] bridge0: port 2(bridge_slave_1) entered disabled state [ 277.248721][ T5109] bridge_slave_1: entered allmulticast mode [ 277.255333][ T5109] bridge_slave_1: entered promiscuous mode [ 277.277981][ T5109] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 277.289100][ T5109] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 277.313816][ T5109] team0: Port device team_slave_0 added [ 277.321134][ T5109] team0: Port device team_slave_1 added [ 277.339501][ T5109] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 277.346455][ T5109] 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. [ 277.372484][ T5109] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 277.385380][ T5109] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 277.392442][ T5109] 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. [ 277.418508][ T5109] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 277.446871][ T5109] hsr_slave_0: entered promiscuous mode [ 277.453208][ T5109] hsr_slave_1: entered promiscuous mode [ 277.460041][ T5109] debugfs: Directory 'hsr0' with parent 'hsr' already present! [ 277.467945][ T5109] Cannot create hsr debugfs directory [ 277.533031][ T5109] bridge0: port 2(bridge_slave_1) entered blocking state [ 277.540147][ T5109] bridge0: port 2(bridge_slave_1) entered forwarding state [ 277.547477][ T5109] bridge0: port 1(bridge_slave_0) entered blocking state [ 277.554619][ T5109] bridge0: port 1(bridge_slave_0) entered forwarding state [ 277.596124][ T5109] 8021q: adding VLAN 0 to HW filter on device bond0 [ 277.610530][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 277.620880][ T900] bridge0: port 1(bridge_slave_0) entered disabled state [ 277.628607][ T900] bridge0: port 2(bridge_slave_1) entered disabled state [ 277.642299][ T5109] 8021q: adding VLAN 0 to HW filter on device team0 [ 277.660265][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 277.668796][ T900] bridge0: port 1(bridge_slave_0) entered blocking state [ 277.675890][ T900] bridge0: port 1(bridge_slave_0) entered forwarding state [ 277.683837][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 277.692317][ T900] bridge0: port 2(bridge_slave_1) entered blocking state [ 277.699489][ T900] bridge0: port 2(bridge_slave_1) entered forwarding state [ 277.714081][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 277.723173][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 277.735539][ T21] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 277.753129][ T5109] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 277.763813][ T5109] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 277.776399][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 277.784967][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 277.793853][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 277.811298][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 277.819969][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 277.832215][ T5109] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 278.128917][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 278.137534][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 278.149884][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 278.158491][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 278.170550][ T5109] veth0_vlan: entered promiscuous mode [ 278.178941][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 278.186886][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 278.197555][ T5109] veth1_vlan: entered promiscuous mode [ 278.213958][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 278.224086][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 278.232444][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 278.242277][ T1615] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 278.254093][ T5109] veth0_macvtap: entered promiscuous mode [ 278.263728][ T5109] veth1_macvtap: entered promiscuous mode [ 278.276688][ T5109] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3d) already exists on: batadv_slave_0 [ 278.287545][ T5109] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 278.299046][ T5109] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 278.306956][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 278.315378][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 278.323599][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 278.332428][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 278.344301][ T5109] batman_adv: The newly added mac address (aa:aa:aa:aa:aa:3e) already exists on: batadv_slave_1 [ 278.355602][ T5109] batman_adv: It is strongly recommended to keep mac addresses unique to avoid problems! [ 278.366794][ T5109] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 278.375770][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 278.384675][ T900] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 307.139813][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 210 seconds [ 337.223715][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 240 seconds [ 367.299050][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 270 seconds [ 397.379131][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 300 seconds [ 427.459030][ T51] block nbd0: Possible stuck request ffff88801f7a0000: control (read@0,4096B). Runtime 330 seconds [ 431.299130][ T27] INFO: task udevd:5061 blocked for more than 143 seconds. [ 431.306545][ T27] Not tainted 6.4.0-rc1-syzkaller-00012-g16a8829130ca #0 [ 431.314457][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 431.323276][ T27] task:udevd state:D stack:26952 pid:5061 ppid:4445 flags:0x00004006 [ 431.332797][ T27] Call Trace: [ 431.336105][ T27] [ 431.339106][ T27] __schedule+0xc9a/0x5880 [ 431.343563][ T27] ? mark_lock.part.0+0xee/0x1970 [ 431.348587][ T27] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 431.354730][ T27] ? __lock_acquire+0xbe1/0x5df0 [ 431.359721][ T27] ? io_schedule_timeout+0x150/0x150 [ 431.365021][ T27] ? find_held_lock+0x2d/0x110 [ 431.369961][ T27] ? lock_downgrade+0x690/0x690 [ 431.375022][ T27] schedule+0xde/0x1a0 [ 431.379245][ T27] io_schedule+0xbe/0x130 [ 431.383610][ T27] folio_wait_bit_common+0x394/0x9b0 [ 431.389080][ T27] ? filemap_get_folios_contig+0xa70/0xa70 [ 431.394942][ T27] ? filemap_get_entry+0x225/0x430 [ 431.400161][ T27] ? __folio_lock_or_retry+0x240/0x240 [ 431.406334][ T27] ? folio_unlock+0xd0/0xd0 [ 431.410961][ T27] __filemap_get_folio+0x789/0x990 [ 431.416102][ T27] truncate_inode_pages_range+0x350/0xf10 [ 431.421924][ T27] ? truncate_inode_partial_folio+0x750/0x750 [ 431.428034][ T27] ? has_bh_in_lru+0x8f/0xe0 [ 431.432701][ T27] ? smp_call_function_many_cond+0x40a/0x15a0 [ 431.438897][ T27] ? generic_remap_file_range_prep+0x50/0x50 [ 431.444912][ T27] ? __brelse+0xa0/0xa0 [ 431.449197][ T27] ? trace_ipi_send_cpu+0x1d0/0x1d0 [ 431.454465][ T27] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 431.460185][ T27] ? __brelse+0xa0/0xa0 [ 431.464542][ T27] blkdev_flush_mapping+0x152/0x320 [ 431.469907][ T27] blkdev_put_whole+0xcb/0xf0 [ 431.474635][ T27] blkdev_put+0x220/0x780 [ 431.479034][ T27] blkdev_close+0x68/0x80 [ 431.483424][ T27] __fput+0x27c/0xa90 [ 431.487437][ T27] ? blkdev_fsync+0xa0/0xa0 [ 431.492020][ T27] task_work_run+0x16f/0x270 [ 431.496704][ T27] ? task_work_cancel+0x30/0x30 [ 431.501670][ T27] ? do_raw_spin_unlock+0x175/0x230 [ 431.506929][ T27] do_exit+0xad3/0x2960 [ 431.511201][ T27] ? find_held_lock+0x2d/0x110 [ 431.516114][ T27] ? get_signal+0x89d/0x25b0 [ 431.520799][ T27] ? mm_update_next_owner+0x7b0/0x7b0 [ 431.526201][ T27] ? do_raw_spin_lock+0x124/0x2b0 [ 431.531410][ T27] ? spin_bug+0x1c0/0x1c0 [ 431.535780][ T27] do_group_exit+0xd4/0x2a0 [ 431.540381][ T27] get_signal+0x2315/0x25b0 [ 431.544913][ T27] ? exit_signals+0x910/0x910 [ 431.549683][ T27] ? do_sys_openat2+0xa1/0x4c0 [ 431.554463][ T27] arch_do_signal_or_restart+0x79/0x5c0 [ 431.560130][ T27] ? get_sigframe_size+0x10/0x10 [ 431.565115][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 431.570147][ T27] exit_to_user_mode_prepare+0x11f/0x240 [ 431.575807][ T27] syscall_exit_to_user_mode+0x1d/0x50 [ 431.581327][ T27] do_syscall_64+0x46/0xb0 [ 431.585773][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 431.591807][ T27] RIP: 0033:0x7f4c7d1169a4 [ 431.596241][ T27] RSP: 002b:00007ffd8d5256d0 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 [ 431.604915][ T27] RAX: 0000000000000008 RBX: 0000560af73fa840 RCX: 00007f4c7d1169a4 [ 431.613015][ T27] RDX: 00000000000a0800 RSI: 0000560af73faf70 RDI: 00000000ffffff9c [ 431.621048][ T27] RBP: 0000560af73faf70 R08: 0000000000000001 R09: 00007ffd8d5ed080 [ 431.629081][ T27] R10: 0000000000000000 R11: 0000000000000246 R12: 00000000000a0800 [ 431.637056][ T27] R13: 0000560af73f7e00 R14: 0000000000000001 R15: 0000560af73ce2c0 [ 431.645131][ T27] [ 431.648260][ T27] INFO: task syz-executor.0:5128 blocked for more than 143 seconds. [ 431.656352][ T27] Not tainted 6.4.0-rc1-syzkaller-00012-g16a8829130ca #0 [ 431.663938][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 431.672676][ T27] task:syz-executor.0 state:D stack:28072 pid:5128 ppid:5109 flags:0x00000004 [ 431.681925][ T27] Call Trace: [ 431.685221][ T27] [ 431.688332][ T27] __schedule+0xc9a/0x5880 [ 431.692851][ T27] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 431.699037][ T27] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 431.705146][ T27] ? io_schedule_timeout+0x150/0x150 [ 431.710494][ T27] ? __mutex_lock+0xa36/0x1350 [ 431.715279][ T27] schedule+0xde/0x1a0 [ 431.719678][ T27] schedule_preempt_disabled+0x13/0x20 [ 431.725680][ T27] __mutex_lock+0xa3b/0x1350 [ 431.730358][ T27] ? blkdev_get_by_dev.part.0+0x95/0xb80 [ 431.736023][ T27] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 431.741615][ T27] ? _atomic_dec_and_lock+0x96/0x100 [ 431.747028][ T27] ? disk_block_events+0x21/0x140 [ 431.752168][ T27] blkdev_get_by_dev.part.0+0x95/0xb80 [ 431.757651][ T27] ? devcgroup_check_permission+0x1aa/0x4a0 [ 431.763788][ T27] blkdev_get_by_dev+0x6f/0x90 [ 431.768757][ T27] blkdev_open+0x140/0x2d0 [ 431.773233][ T27] do_dentry_open+0x6cc/0x13f0 [ 431.778242][ T27] ? blkdev_close+0x80/0x80 [ 431.782994][ T27] path_openat+0x1baa/0x2750 [ 431.787642][ T27] ? path_lookupat+0x840/0x840 [ 431.792606][ T27] ? find_held_lock+0x2d/0x110 [ 431.797395][ T27] do_filp_open+0x1ba/0x410 [ 431.802399][ T27] ? may_open_dev+0xf0/0xf0 [ 431.806944][ T27] ? find_held_lock+0x2d/0x110 [ 431.811789][ T27] ? do_raw_spin_lock+0x124/0x2b0 [ 431.817108][ T27] ? spin_bug+0x1c0/0x1c0 [ 431.821492][ T27] ? _raw_spin_unlock+0x28/0x40 [ 431.826574][ T27] ? alloc_fd+0x2e4/0x750 [ 431.831726][ T27] do_sys_openat2+0x16d/0x4c0 [ 431.836514][ T27] ? build_open_flags+0x720/0x720 [ 431.841646][ T27] ? do_user_addr_fault+0x367/0x1210 [ 431.847071][ T27] ? lock_downgrade+0x690/0x690 [ 431.852006][ T27] __x64_sys_openat+0x143/0x1f0 [ 431.856880][ T27] ? __ia32_sys_open+0x1c0/0x1c0 [ 431.862580][ T27] ? syscall_enter_from_user_mode+0x26/0x80 [ 431.869229][ T27] do_syscall_64+0x39/0xb0 [ 431.873692][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 431.879647][ T27] RIP: 0033:0x417734 [ 431.883550][ T27] RSP: 002b:00007f742d5b1c50 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 431.892063][ T27] RAX: ffffffffffffffda RBX: 6666666666666667 RCX: 0000000000417734 [ 431.900123][ T27] RDX: 0000000000000000 RSI: 00007f742d5b1d70 RDI: 00000000ffffff9c [ 431.908108][ T27] RBP: 00007f742d5b1d70 R08: 0000000000000000 R09: 002364626e2f7665 [ 431.916146][ T27] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000 [ 431.924191][ T27] R13: 00007f742d5b26bc R14: 00000000ffffffff R15: 0000000000000003 [ 431.932261][ T27] [ 431.935302][ T27] [ 431.935302][ T27] Showing all locks held in the system: [ 431.943407][ T27] 1 lock held by rcu_tasks_kthre/12: [ 431.948852][ T27] #0: ffffffff8c795470 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 [ 431.959437][ T27] 1 lock held by rcu_tasks_trace/13: [ 431.964744][ T27] #0: ffffffff8c795170 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x31/0xd80 [ 431.975930][ T27] 1 lock held by khungtaskd/27: [ 431.980834][ T27] #0: ffffffff8c796080 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x340 [ 431.990886][ T27] 2 locks held by getty/4747: [ 431.995584][ T27] #0: ffff88814bd49098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x26/0x80 [ 432.005676][ T27] #1: ffffc900020182f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xef4/0x13e0 [ 432.015983][ T27] 1 lock held by udevd/5061: [ 432.020859][ T27] #0: ffff888140bf64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xba/0x780 [ 432.031367][ T27] 1 lock held by syz-executor.0/5128: [ 432.036742][ T27] #0: ffff888140bf64c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x95/0xb80 [ 432.047400][ T27] [ 432.049822][ T27] ============================================= [ 432.049822][ T27] [ 432.058302][ T27] NMI backtrace for cpu 0 [ 432.062626][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 6.4.0-rc1-syzkaller-00012-g16a8829130ca #0 [ 432.072427][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 432.082754][ T27] Call Trace: [ 432.086039][ T27] [ 432.088978][ T27] dump_stack_lvl+0xd9/0x150 [ 432.093564][ T27] nmi_cpu_backtrace+0x29c/0x350 [ 432.098509][ T27] ? lapic_can_unplug_cpu+0xa0/0xa0 [ 432.103699][ T27] nmi_trigger_cpumask_backtrace+0x2a4/0x300 [ 432.109693][ T27] watchdog+0xe16/0x1090 [ 432.114048][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 432.120046][ T27] kthread+0x344/0x440 [ 432.124146][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 432.129793][ T27] ret_from_fork+0x1f/0x30 [ 432.134226][ T27] [ 432.137528][ T27] Sending NMI from CPU 0 to CPUs 1: [ 432.142909][ C1] NMI backtrace for cpu 1 skipped: idling at acpi_safe_halt+0x40/0x50 [ 432.144314][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 432.159351][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 6.4.0-rc1-syzkaller-00012-g16a8829130ca #0 [ 432.169151][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023 [ 432.179207][ T27] Call Trace: [ 432.182483][ T27] [ 432.185420][ T27] dump_stack_lvl+0xd9/0x150 [ 432.190013][ T27] panic+0x686/0x730 [ 432.193923][ T27] ? panic_smp_self_stop+0xa0/0xa0 [ 432.199042][ T27] ? lapic_can_unplug_cpu+0xa0/0xa0 [ 432.204266][ T27] ? preempt_schedule_thunk+0x1a/0x20 [ 432.209667][ T27] ? watchdog+0xbe8/0x1090 [ 432.214102][ T27] watchdog+0xbf9/0x1090 [ 432.218382][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 432.224392][ T27] kthread+0x344/0x440 [ 432.228500][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 432.234268][ T27] ret_from_fork+0x1f/0x30 [ 432.238717][ T27] [ 432.242140][ T27] Kernel Offset: disabled [ 432.246498][ T27] Rebooting in 86400 seconds..