Warning: Permanently added '10.128.10.17' (ED25519) to the list of known hosts.
2023/08/06 07:54:47 ignoring optional flag "sandboxArg"="0"
2023/08/06 07:54:47 parsed 1 programs
[ 45.830629][ T25] audit: type=1400 audit(1691308487.971:173): avc: denied { getattr } for pid=1910 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
[ 45.854382][ T25] audit: type=1400 audit(1691308487.971:174): avc: denied { read } for pid=1910 comm="syz-execprog" dev="nsfs" ino=4026531837 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1
[ 45.875718][ T25] audit: type=1400 audit(1691308487.971:175): avc: denied { open } for pid=1910 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
[ 45.899578][ T25] audit: type=1400 audit(1691308487.971:176): avc: denied { mounton } for pid=1915 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
[ 45.924665][ T25] audit: type=1400 audit(1691308487.971:177): avc: denied { mount } for pid=1915 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/08/06 07:54:48 executed programs: 0
[ 45.987744][ T25] audit: type=1400 audit(1691308488.131:178): avc: denied { unlink } for pid=1915 comm="syz-executor" name="swap-file" dev="sda1" ino=1928 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:unlabeled_t tclass=file permissive=1 trawcon="root:object_r:swapfile_t"
[ 46.020100][ T1915] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k
[ 46.037953][ T25] audit: type=1400 audit(1691308488.181:179): avc: denied { ioctl } for pid=1921 comm="syz-executor.0" path="socket:[17676]" dev="sockfs" ino=17676 ioctlcmd=0x48c9 scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=bluetooth_socket permissive=1
[ 46.040243][ T1253] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[ 46.070616][ T1253] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[ 46.077693][ T1253] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[ 46.084961][ T1406] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[ 46.092143][ T1406] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3
[ 46.099413][ T1406] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[ 46.108856][ T25] audit: type=1400 audit(1691308488.251:180): avc: denied { mounton } for pid=1921 comm="syz-executor.0" path="/" dev="sda1" ino=2 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:root_t tclass=dir permissive=1
[ 46.160109][ T1921] chnl_net:caif_netlink_parms(): no params data found
[ 46.408612][ T25] audit: type=1400 audit(1691308488.551:181): avc: denied { write } for pid=1921 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1
[ 46.429692][ T25] audit: type=1400 audit(1691308488.551:182): avc: denied { read } for pid=1921 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1
[ 46.605232][ T1921] 8021q: adding VLAN 0 to HW filter on device bond0
[ 46.869625][ T1921] 8021q: adding VLAN 0 to HW filter on device batadv0
[ 47.418514][ T2324] nbd0: detected capacity change from 0 to 65538
[ 48.177351][ T42] Bluetooth: hci0: command 0x0409 tx timeout
[ 48.178536][ T1406] block nbd0: Receive control failed (result -104)
[ 50.257255][ T1406] Bluetooth: hci0: command 0x041b tx timeout
[ 52.337333][ T1406] Bluetooth: hci0: command 0x040f tx timeout
[ 54.417284][ T42] Bluetooth: hci0: command 0x0419 tx timeout
[ 77.937321][ T1242] block nbd0: Possible stuck request ffff888100ee8000: control (read@0,4096B). Runtime 30 seconds
2023/08/06 07:55:44 executed programs: 1
[ 103.354482][ T1406] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1
[ 103.361630][ T1406] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9
[ 103.368882][ T1406] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9
[ 103.376310][ T1406] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4
[ 103.383574][ T1406] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3
[ 103.390674][ T1253] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2
[ 103.445695][ T2326] chnl_net:caif_netlink_parms(): no params data found
[ 103.878808][ T2326] 8021q: adding VLAN 0 to HW filter on device bond0
[ 104.139278][ T2326] 8021q: adding VLAN 0 to HW filter on device batadv0
[ 105.467249][ T42] Bluetooth: hci1: command 0x0409 tx timeout
[ 107.537230][ T42] Bluetooth: hci1: command 0x041b tx timeout
[ 107.617810][ T1294] udevd[1294]: worker [1922] /devices/virtual/block/nbd0 is taking a long time
[ 108.017313][ T1242] block nbd0: Possible stuck request ffff888100ee8000: control (read@0,4096B). Runtime 60 seconds
[ 109.617275][ T1406] Bluetooth: hci1: command 0x040f tx timeout
[ 111.697259][ T42] Bluetooth: hci1: command 0x0419 tx timeout
[ 138.097299][ T1242] block nbd0: Possible stuck request ffff888100ee8000: control (read@0,4096B). Runtime 90 seconds
2023/08/06 07:56:41 executed programs: 2
[ 160.621419][ T42] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1
[ 160.628505][ T1253] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9
[ 160.635558][ T42] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9
[ 160.643108][ T1253] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4
[ 160.650901][ T1253] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3
[ 160.658117][ T1253] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2
[ 160.711724][ T2730] chnl_net:caif_netlink_parms(): no params data found
[ 161.152135][ T2730] 8021q: adding VLAN 0 to HW filter on device bond0
[ 161.431294][ T2730] 8021q: adding VLAN 0 to HW filter on device batadv0
[ 162.737214][ T1253] Bluetooth: hci2: command 0x0409 tx timeout
[ 164.817203][ T1253] Bluetooth: hci2: command 0x041b tx timeout
[ 166.897248][ T1253] Bluetooth: hci2: command 0x040f tx timeout
[ 168.177283][ T1242] block nbd0: Possible stuck request ffff888100ee8000: control (read@0,4096B). Runtime 120 seconds
[ 168.977216][ T1253] Bluetooth: hci2: command 0x0419 tx timeout
[ 169.617222][ T1253] Bluetooth: hci0: command 0x0406 tx timeout
[ 198.257268][ T1242] block nbd0: Possible stuck request ffff888100ee8000: control (read@0,4096B). Runtime 150 seconds
[ 209.137236][ T27] INFO: task syz-executor.0:2323 blocked for more than 143 seconds.
[ 209.145516][ T27] Not tainted 6.5.0-rc4-syzkaller #0
[ 209.151409][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 209.160106][ T27] task:syz-executor.0 state:D stack:14552 pid:2323 ppid:1921 flags:0x00004006
[ 209.169392][ T27] Call Trace:
[ 209.172644][ T27]
[ 209.175652][ T27] __schedule+0x3a2/0x9e0
[ 209.179965][ T27] schedule+0x59/0xa0
[ 209.183923][ T27] schedule_preempt_disabled+0x1b/0xa0
[ 209.189386][ T27] __mutex_lock+0x53b/0x9e0
[ 209.194030][ T27] ? blkdev_put+0x38/0x1c0
[ 209.198439][ T27] ? blkdev_put+0x38/0x1c0
[ 209.202836][ T27] blkdev_put+0x38/0x1c0
[ 209.207041][ T27] blkdev_release+0x26/0x30
[ 209.211528][ T27] __fput+0xeb/0x290
[ 209.215397][ T27] task_work_run+0x55/0x80
[ 209.219803][ T27] exit_to_user_mode_prepare+0x13f/0x150
[ 209.225507][ T27] syscall_exit_to_user_mode+0x16/0x30
[ 209.231074][ T27] do_syscall_64+0x44/0xb0
[ 209.235479][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 209.241356][ T27] RIP: 0033:0x7fe22707cb29
[ 209.245763][ T27] RSP: 002b:00007fe227e710c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[ 209.254245][ T27] RAX: 0000000000000000 RBX: 00007fe22719bf80 RCX: 00007fe22707cb29
[ 209.262199][ T27] RDX: 0000000000000000 RSI: 000000000000ab03 RDI: 0000000000000003
[ 209.270325][ T27] RBP: 00007fe2270c847a R08: 0000000000000000 R09: 0000000000000000
[ 209.278286][ T27] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
[ 209.286317][ T27] R13: 0000000000000006 R14: 00007fe22719bf80 R15: 00007ffcf3e63ca8
[ 209.294623][ T27]
[ 209.297639][ T27]
[ 209.297639][ T27] Showing all locks held in the system:
[ 209.305626][ T27] 1 lock held by rcu_tasks_kthre/12:
[ 209.310901][ T27] #0: ffffffff83381e50 (rcu_tasks.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_one_gp+0x26/0x3d0
[ 209.322015][ T27] 1 lock held by rcu_tasks_trace/13:
[ 209.327379][ T27] #0: ffffffff83381b90 (rcu_tasks_trace.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_one_gp+0x26/0x3d0
[ 209.338341][ T27] 1 lock held by khungtaskd/27:
[ 209.343159][ T27] #0: ffffffff83382500 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x12/0x120
[ 209.352995][ T27] 2 locks held by getty/1355:
[ 209.357658][ T27] #0: ffff8881102c9098 (&tty->ldisc_sem){....}-{0:0}, at: tty_ldisc_ref_wait+0x23/0x50
[ 209.367473][ T27] #1: ffffc900003fb2f0 (&ldata->atomic_read_lock){....}-{3:3}, at: n_tty_read+0x51c/0x650
[ 209.377489][ T27] 1 lock held by udevd/1922:
[ 209.382049][ T27] #0: ffff888100aad4c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev.part.0+0xfb/0x330
[ 209.392618][ T27] 1 lock held by syz-executor.0/2323:
[ 209.398063][ T27] #0: ffff888100aad4c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_put+0x38/0x1c0
[ 209.407352][ T27] 1 lock held by syz-executor.0/2727:
[ 209.412692][ T27] #0: ffff888100aad4c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev.part.0+0xfb/0x330
[ 209.423277][ T27] 1 lock held by syz-executor.0/3130:
[ 209.428628][ T27] #0: ffff888100aad4c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev.part.0+0xfb/0x330
[ 209.439147][ T27]
[ 209.441453][ T27] =============================================
[ 209.441453][ T27]
[ 209.449857][ T27] NMI backtrace for cpu 1
[ 209.454163][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 6.5.0-rc4-syzkaller #0
[ 209.462187][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023
[ 209.472308][ T27] Call Trace:
[ 209.475570][ T27]
[ 209.478656][ T27] dump_stack_lvl+0x3d/0x60
[ 209.483240][ T27] nmi_cpu_backtrace+0xcc/0x110
[ 209.488233][ T27] ? lapic_can_unplug_cpu+0xa0/0xa0
[ 209.493498][ T27] nmi_trigger_cpumask_backtrace+0x115/0x130
[ 209.499448][ T27] watchdog+0x593/0x5c0
[ 209.503700][ T27] ? proc_dohung_task_timeout_secs+0x30/0x30
[ 209.509645][ T27] kthread+0xde/0x110
[ 209.513590][ T27] ? kthread_complete_and_exit+0x20/0x20
[ 209.519281][ T27] ret_from_fork+0x2c/0x40
[ 209.523673][ T27] ? kthread_complete_and_exit+0x20/0x20
[ 209.529452][ T27] ret_from_fork_asm+0x11/0x20
[ 209.534184][ T27]
[ 209.537229][ T27] Sending NMI from CPU 1 to CPUs 0:
[ 209.542431][ C0] NMI backtrace for cpu 0 skipped: idling at acpi_safe_halt+0x1b/0x20
[ 209.543407][ T27] Kernel panic - not syncing: hung_task: blocked tasks
[ 209.558612][ T27] Kernel Offset: disabled
[ 209.562928][ T27] Rebooting in 86400 seconds..