Warning: Permanently added '10.128.10.39' (ED25519) to the list of known hosts. 2024/05/19 15:37:02 ignoring optional flag "sandboxArg"="0" 2024/05/19 15:37:02 parsed 1 programs 2024/05/19 15:37:02 executed programs: 0 [ 43.050850][ T2261] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k FS [ 43.385640][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 43.393962][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 43.417657][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 43.426440][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 43.434596][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 43.442740][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 43.583896][ T2267] device veth0_vlan entered promiscuous mode [ 43.590656][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 43.600108][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 43.608059][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 43.615821][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 43.696495][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 43.746360][ T27] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 43.755609][ T27] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 43.790814][ T2451] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 43.797331][ T2451] vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) [ 43.805185][ T2451] vhci_hcd vhci_hcd.0: Device attached [ 44.151734][ T27] usb 9-1: new high-speed USB device number 2 using vhci_hcd 2024/05/19 15:37:33 executed programs: 1 [ 75.139820][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 75.148288][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 75.173775][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.182486][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.190919][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 75.199605][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 75.349940][ T2456] device veth0_vlan entered promiscuous mode [ 75.356753][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 75.365226][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 75.373193][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 75.380641][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 75.475099][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 75.520245][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 75.528816][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 75.615421][ T2643] vhci_hcd vhci_hcd.0: port 0 already used 2024/05/19 15:38:04 executed programs: 2 [ 106.902779][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 106.910166][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 106.934186][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 106.942984][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 106.952177][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 106.960118][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 107.108135][ T2647] device veth0_vlan entered promiscuous mode [ 107.114584][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 107.123170][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 107.130958][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 107.139392][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 107.231307][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 107.276965][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 107.286094][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 107.372406][ T2833] vhci_hcd vhci_hcd.0: port 0 already used 2024/05/19 15:38:36 executed programs: 3 [ 138.649929][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 138.657766][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 138.681879][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 138.690116][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 138.700260][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 138.709117][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 138.852163][ T2837] device veth0_vlan entered promiscuous mode [ 138.858918][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 138.867563][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 138.875662][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 138.883217][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 138.964583][ T2556] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 139.015579][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 139.024390][ T17] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 139.111501][ T3023] vhci_hcd vhci_hcd.0: port 0 already used 2024/05/19 15:39:08 executed programs: 4 [ 170.448991][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 170.457268][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 170.480675][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 170.488866][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 170.497108][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 170.506462][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 170.653727][ T3028] device veth0_vlan entered promiscuous mode [ 170.660520][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 170.669533][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 170.678156][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 170.685499][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 170.769460][ T2067] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 170.817407][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 170.825714][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 170.912327][ T3214] vhci_hcd vhci_hcd.0: port 0 already used [ 187.351754][ T28] INFO: task syz-executor.0:2450 blocked for more than 143 seconds. [ 187.360013][ T28] Not tainted 6.1.91-syzkaller #0 [ 187.365630][ T28] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 187.374386][ T28] task:syz-executor.0 state:D stack:13768 pid:2450 ppid:2267 flags:0x00004006 [ 187.383677][ T28] Call Trace: [ 187.386933][ T28] [ 187.390022][ T28] __schedule+0x5b6/0x1130 [ 187.394534][ T28] ? usbdev_release+0x27/0x200 [ 187.399444][ T28] schedule+0x50/0xb0 [ 187.403442][ T28] schedule_preempt_disabled+0x2e/0x40 [ 187.409174][ T28] __mutex_lock+0x43b/0x940 [ 187.413931][ T28] usbdev_release+0x27/0x200 [ 187.418494][ T28] __fput+0xe1/0x210 [ 187.422461][ T28] task_work_run+0x79/0xa0 [ 187.426855][ T28] exit_to_user_mode_loop+0xa9/0xc0 [ 187.432052][ T28] exit_to_user_mode_prepare+0x6c/0xc0 [ 187.437484][ T28] syscall_exit_to_user_mode+0x27/0x1b0 [ 187.443018][ T28] do_syscall_64+0x47/0xb0 [ 187.447517][ T28] ? clear_bhb_loop+0x45/0xa0 [ 187.452195][ T28] entry_SYSCALL_64_after_hwframe+0x68/0xd2 [ 187.458148][ T28] RIP: 0033:0x7fccc5a7cd5a [ 187.462824][ T28] RSP: 002b:00007ffc55fdf420 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 187.471332][ T28] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007fccc5a7cd5a [ 187.479470][ T28] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 [ 187.487425][ T28] RBP: 0000000000000032 R08: 0000001b31660000 R09: 00007fccc5babf8c [ 187.495428][ T28] R10: 00007ffc55fdf570 R11: 0000000000000293 R12: 00007fccc56000c8 [ 187.503439][ T28] R13: ffffffffffffffff R14: 00007fccc5600000 R15: 000000000000aaee [ 187.511494][ T28] [ 187.514542][ T28] [ 187.514542][ T28] Showing all locks held in the system: [ 187.522392][ T28] 1 lock held by rcu_tasks_kthre/12: [ 187.527828][ T28] #0: ffffffff83b87508 (rcu_tasks.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_kthread+0x98/0x450 [ 187.538477][ T28] 1 lock held by rcu_tasks_trace/13: [ 187.543870][ T28] #0: ffffffff83b87b58 (rcu_tasks_trace.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_kthread+0x98/0x450 [ 187.554883][ T28] 5 locks held by kworker/1:1/27: [ 187.560499][ T28] #0: ffff8881001f6538 ((wq_completion)usb_hub_wq){....}-{0:0}, at: process_one_work+0x1da/0x470 [ 187.571198][ T28] #1: ffffc90000147e68 ((work_completion)(&hub->events)){....}-{0:0}, at: process_one_work+0x1da/0x470 [ 187.582454][ T28] #2: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: hub_event+0x7c/0x1bd0 [ 187.592545][ T28] #3: ffff88814824f4f0 (&port_dev->status_lock){....}-{3:3}, at: hub_event+0xded/0x1bd0 [ 187.602524][ T28] #4: ffff888147e4b428 (hcd->address0_mutex){....}-{3:3}, at: hub_event+0xe00/0x1bd0 [ 187.612589][ T28] 1 lock held by khungtaskd/28: [ 187.617418][ T28] #0: ffffffff83b873e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x2c/0x100 [ 187.627223][ T28] 2 locks held by getty/1924: [ 187.631881][ T28] #0: ffff88810bd33898 (&tty->ldisc_sem){....}-{0:0}, at: tty_ldisc_ref_wait+0x1c/0x40 [ 187.641683][ T28] #1: ffffc900075432f0 (&ldata->atomic_read_lock){....}-{3:3}, at: n_tty_read+0x20a/0x8e0 [ 187.652110][ T28] 1 lock held by syz-executor.0/2450: [ 187.657462][ T28] #0: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x27/0x200 [ 187.666580][ T28] 1 lock held by syz-executor.0/2641: [ 187.672202][ T28] #0: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xae/0x2d0 [ 187.681767][ T28] 1 lock held by syz-executor.0/2831: [ 187.687289][ T28] #0: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xae/0x2d0 [ 187.696424][ T28] 1 lock held by syz-executor.0/3021: [ 187.701971][ T28] #0: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xae/0x2d0 [ 187.711003][ T28] 1 lock held by syz-executor.0/3212: [ 187.716469][ T28] #0: ffff88814824d190 (&dev->mutex){....}-{3:3}, at: usbdev_open+0xae/0x2d0 [ 187.725620][ T28] [ 187.727932][ T28] ============================================= [ 187.727932][ T28] [ 187.736516][ T28] NMI backtrace for cpu 0 [ 187.741003][ T28] CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.1.91-syzkaller #0 [ 187.748966][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024 [ 187.759178][ T28] Call Trace: [ 187.762433][ T28] [ 187.765378][ T28] dump_stack_lvl+0x7f/0xc2 [ 187.769938][ T28] nmi_cpu_backtrace+0x13e/0x160 [ 187.774904][ T28] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 187.782239][ T28] nmi_trigger_cpumask_backtrace+0x9c/0x150 [ 187.788107][ T28] watchdog+0x54d/0x570 [ 187.792232][ T28] ? watchdog+0xc9/0x570 [ 187.796438][ T28] ? hungtask_pm_notify+0x20/0x20 [ 187.801514][ T28] kthread+0xd1/0xe0 [ 187.805385][ T28] ? kthread_blkcg+0x30/0x30 [ 187.810206][ T28] ret_from_fork+0x1f/0x30 [ 187.814602][ T28] [ 187.817674][ T28] Sending NMI from CPU 0 to CPUs 1: [ 187.822959][ C1] NMI backtrace for cpu 1 [ 187.822962][ C1] CPU: 1 PID: 9 Comm: kworker/u4:0 Not tainted 6.1.91-syzkaller #0 [ 187.822964][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024 [ 187.822966][ C1] Workqueue: writeback wb_workfn (flush-8:0) [ 187.822974][ C1] RIP: 0010:move_expired_inodes+0x0/0x1d0 [ 187.822980][ C1] Code: 3e 00 7f a8 eb 06 31 db eb a2 31 db 48 89 d8 48 83 c4 08 5b 41 5c 41 5d 41 5e 41 5f 5d c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 <55> 41 57 41 56 41 55 41 54 53 48 83 ec 30 48 89 54 24 10 49 89 f6 [ 187.822983][ C1] RSP: 0018:ffffc9000009bcd8 EFLAGS: 00000246 [ 187.822986][ C1] RAX: ffff88814007a098 RBX: ffff88814007a060 RCX: ffff88814007a098 [ 187.822988][ C1] RDX: 00000000ffffc837 RSI: ffff88814007a088 RDI: ffff88814007a078 [ 187.822990][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 187.822991][ C1] R10: 0000000000000000 R11: 0000001000000000 R12: ffff88814007a088 [ 187.822993][ C1] R13: 0000000000000000 R14: ffffc9000009bde8 R15: 00000000ffffc837 [ 187.822995][ C1] FS: 0000000000000000(0000) GS:ffff88813bd00000(0000) knlGS:0000000000000000 [ 187.822997][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 187.822999][ C1] CR2: 00007fd0feaf17a3 CR3: 0000000003a21000 CR4: 00000000003506e0 [ 187.823004][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 187.823005][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 187.823007][ C1] Call Trace: [ 187.823009][ C1] [ 187.823011][ C1] ? nmi_cpu_backtrace+0x108/0x160 [ 187.823015][ C1] ? nmi_cpu_backtrace_handler+0x8/0x10 [ 187.823020][ C1] ? nmi_handle+0x96/0x1b0 [ 187.823024][ C1] ? nmi_handle+0x25/0x1b0 [ 187.823026][ C1] ? __writeback_inodes_wb+0xe0/0xe0 [ 187.823030][ C1] ? default_do_nmi+0x62/0x150 [ 187.823033][ C1] ? exc_nmi+0xa8/0x100 [ 187.823035][ C1] ? end_repeat_nmi+0x16/0x31 [ 187.823046][ C1] ? __writeback_inodes_wb+0xe0/0xe0 [ 187.823050][ C1] ? __writeback_inodes_wb+0xe0/0xe0 [ 187.823053][ C1] ? __writeback_inodes_wb+0xe0/0xe0 [ 187.823057][ C1] [ 187.823058][ C1] [ 187.823059][ C1] queue_io+0x5a/0x120 [ 187.823063][ C1] wb_writeback+0x164/0x3c0 [ 187.823067][ C1] ? wb_workfn+0x1bf/0x500 [ 187.823071][ C1] wb_workfn+0x368/0x500 [ 187.823075][ C1] ? process_one_work+0x1da/0x470 [ 187.823078][ C1] process_one_work+0x235/0x470 [ 187.823081][ C1] worker_thread+0x214/0x370 [ 187.823084][ C1] ? process_one_work+0x470/0x470 [ 187.823086][ C1] kthread+0xd1/0xe0 [ 187.823089][ C1] ? kthread_blkcg+0x30/0x30 [ 187.823093][ C1] ret_from_fork+0x1f/0x30 [ 187.823098][ C1] [ 187.823974][ T28] Kernel panic - not syncing: hung_task: blocked tasks [ 188.094753][ T28] Kernel Offset: disabled [ 188.099079][ T28] Rebooting in 86400 seconds..