Warning: Permanently added '10.128.1.126' (ED25519) to the list of known hosts.
2023/10/11 20:47:33 ignoring optional flag "sandboxArg"="0"
2023/10/11 20:47:33 parsed 1 programs
2023/10/11 20:47:33 executed programs: 0
[ 44.486935][ T3123] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k
[ 44.993386][ T3128] veth0_vlan: entered promiscuous mode
[ 45.152172][ T3314] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4)
[ 45.159211][ T3314] vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
[ 45.167225][ T3314] vhci_hcd vhci_hcd.0: Device attached
[ 45.172936][ T3315] vhci_hcd: connection closed
[ 45.173114][ T57] vhci_hcd: stop threads
[ 45.182276][ T57] vhci_hcd: release socket
[ 45.186720][ T57] vhci_hcd: disconnect device
[ 45.678676][ T3319] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4)
[ 45.685212][ T3319] vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
[ 45.692971][ T3319] vhci_hcd vhci_hcd.0: Device attached
[ 45.974129][ T934] vhci_hcd: vhci_device speed not set
[ 46.044090][ T934] usb 9-1: new full-speed USB device number 2 using vhci_hcd
2023/10/11 20:48:30 executed programs: 2
[ 101.824509][ T3363] modprobe (3363) used greatest stack depth: 11776 bytes left
[ 102.173485][ T3324] veth0_vlan: entered promiscuous mode
[ 102.375759][ T3511] vhci_hcd vhci_hcd.0: port 0 already used
2023/10/11 20:49:26 executed programs: 3
[ 158.825668][ T3515] veth0_vlan: entered promiscuous mode
[ 159.034636][ T3701] vhci_hcd vhci_hcd.0: port 0 already used
[ 189.294053][ T29] INFO: task syz-executor.0:3318 blocked for more than 143 seconds.
[ 189.302045][ T29] Not tainted 6.6.0-rc5-syzkaller #0
[ 189.307901][ T29] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 189.316577][ T29] task:syz-executor.0 state:D stack:14496 pid:3318 ppid:3128 flags:0x00000006
[ 189.325787][ T29] Call Trace:
[ 189.329053][ T29]
[ 189.331963][ T29] __schedule+0x40d/0x1490
[ 189.336517][ T29] schedule+0x59/0xa0
[ 189.340513][ T29] schedule_preempt_disabled+0x1b/0xa0
[ 189.345990][ T29] __mutex_lock+0x53b/0x9e0
[ 189.350479][ T29] ? usbdev_release+0x2a/0x170
[ 189.355241][ T29] ? usbdev_release+0x2a/0x170
[ 189.360087][ T29] usbdev_release+0x2a/0x170
[ 189.364684][ T29] __fput+0xe8/0x280
[ 189.368571][ T29] __x64_sys_close+0x38/0x80
[ 189.373345][ T29] do_syscall_64+0x38/0xb0
[ 189.377761][ T29] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[ 189.383730][ T29] RIP: 0033:0x7ff80e07b9da
[ 189.388169][ T29] RSP: 002b:00007fff5c3600d0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
[ 189.396589][ T29] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007ff80e07b9da
[ 189.404599][ T29] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003
[ 189.412645][ T29] RBP: 0000000000000032 R08: 0000001b2f360000 R09: 00007ff80e19bf8c
[ 189.420671][ T29] R10: 00007fff5c360220 R11: 0000000000000293 R12: 00007ff80dc000c8
[ 189.428649][ T29] R13: ffffffffffffffff R14: 00007ff80dc00000 R15: 000000000000b255
[ 189.436675][ T29]
[ 189.439693][ T29]
[ 189.439693][ T29] Showing all locks held in the system:
[ 189.447459][ T29] 1 lock held by khungtaskd/29:
[ 189.452390][ T29] #0: ffffffff8398d140 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x36/0x120
[ 189.462223][ T29] 5 locks held by kworker/1:2/934:
[ 189.467347][ T29] #0: ffff888141243738 ((wq_completion)usb_hub_wq){....}-{0:0}, at: process_one_work+0x1a2/0x4c0
[ 189.477954][ T29] #1: ffffc90002833e50 ((work_completion)(&hub->events)){....}-{0:0}, at: process_one_work+0x1a2/0x4c0
[ 189.489078][ T29] #2: ffff888101b8c190 (&dev->mutex){....}-{3:3}, at: hub_event+0x7e/0x1bc0
[ 189.497886][ T29] #3: ffff888101b8e500 (&port_dev->status_lock){....}-{3:3}, at: hub_event+0x10f3/0x1bc0
[ 189.507814][ T29] #4: ffff888143e504e8 (hcd->address0_mutex){....}-{3:3}, at: hub_event+0x1106/0x1bc0
[ 189.517502][ T29] 2 locks held by getty/2952:
[ 189.522172][ T29] #0: ffff88810836f0a0 (&tty->ldisc_sem){....}-{0:0}, at: tty_ldisc_ref_wait+0x23/0x50
[ 189.531929][ T29] #1: ffffc90008f072f0 (&ldata->atomic_read_lock){....}-{3:3}, at: n_tty_read+0x519/0x650
[ 189.541947][ T29] 1 lock held by syz-executor.0/3318:
[ 189.547504][ T29] #0: ffff888101b8c190 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x2a/0x170
[ 189.556625][ T29] 1 lock held by syz-executor.0/3510:
[ 189.561978][ T29] #0: ffff888101b8c190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xd7/0x2d0
[ 189.570964][ T29] 1 lock held by syz-executor.0/3700:
[ 189.576349][ T29] #0: ffff888101b8c190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xd7/0x2d0
[ 189.585208][ T29]
[ 189.587536][ T29] =============================================
[ 189.587536][ T29]
[ 189.595960][ T29] NMI backtrace for cpu 0
[ 189.600275][ T29] CPU: 0 PID: 29 Comm: khungtaskd Not tainted 6.6.0-rc5-syzkaller #0
[ 189.608397][ T29] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023
[ 189.618428][ T29] Call Trace:
[ 189.621702][ T29]
[ 189.624790][ T29] dump_stack_lvl+0x3d/0x60
[ 189.629294][ T29] nmi_cpu_backtrace+0xcc/0x110
[ 189.634123][ T29] ? lapic_can_unplug_cpu+0xa0/0xa0
[ 189.639313][ T29] nmi_trigger_cpumask_backtrace+0xd1/0x130
[ 189.645181][ T29] watchdog+0x615/0x640
[ 189.649311][ T29] ? watchdog+0x1f9/0x640
[ 189.653632][ T29] ? proc_dohung_task_timeout_secs+0x30/0x30
[ 189.659608][ T29] kthread+0xde/0x110
[ 189.663574][ T29] ? kthread_complete_and_exit+0x20/0x20
[ 189.669207][ T29] ret_from_fork+0x2c/0x40
[ 189.673614][ T29] ? kthread_complete_and_exit+0x20/0x20
[ 189.679229][ T29] ret_from_fork_asm+0x11/0x20
[ 189.683979][ T29]
[ 189.687138][ T29] Sending NMI from CPU 0 to CPUs 1:
[ 189.692359][ C1] NMI backtrace for cpu 1 skipped: idling at acpi_safe_halt+0x1b/0x20
[ 189.693353][ T29] Kernel panic - not syncing: hung_task: blocked tasks
[ 189.708654][ T29] Kernel Offset: disabled
[ 189.713067][ T29] Rebooting in 86400 seconds..