Warning: Permanently added '10.128.0.5' (ED25519) to the list of known hosts. 2023/12/11 13:45:48 ignoring optional flag "sandboxArg"="0" 2023/12/11 13:45:48 parsed 1 programs 2023/12/11 13:45:48 executed programs: 0 [ 40.752390][ T42] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 40.759510][ T42] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 40.766595][ T42] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 40.773754][ T42] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 40.781039][ T42] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 40.788191][ T42] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 40.838105][ T1473] chnl_net:caif_netlink_parms(): no params data found [ 41.250563][ T1473] 8021q: adding VLAN 0 to HW filter on device bond0 [ 41.518836][ T1473] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 41.525721][ T119] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 41.533097][ T119] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 42.122800][ T1874] nbd0: detected capacity change from 0 to 131072 [ 42.854584][ T42] block nbd0: Receive control failed (result -104) [ 42.861049][ T1875] block nbd0: shutting down sockets [ 42.866407][ C1] I/O error, dev nbd0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 [ 42.875582][ C1] Buffer I/O error on dev nbd0, logical block 0, async page read [ 42.883575][ T1474] Dev nbd0: unable to read RDB block 0 [ 42.890134][ T1474] nbd0: unable to read partition table [ 42.895867][ T42] Bluetooth: hci0: command 0x0409 tx timeout [ 42.895919][ T1474] nbd0: partition table beyond EOD, truncated [ 43.001998][ T1878] nbd0: detected capacity change from 0 to 131072 [ 43.744846][ T959] block nbd0: Receive control failed (result -104) [ 44.940859][ T959] Bluetooth: hci0: command 0x041b tx timeout [ 47.020886][ T42] Bluetooth: hci0: command 0x040f tx timeout [ 49.100872][ T42] Bluetooth: hci0: command 0x0419 tx timeout [ 73.421194][ T463] block nbd0: Possible stuck request ffff8881013e8200: control (read@0,4096B). Runtime 30 seconds 2023/12/11 13:46:45 executed programs: 2 [ 98.920730][ T959] Bluetooth: hci1: unexpected cc 0x0c03 length: 249 > 1 [ 98.928507][ T959] Bluetooth: hci1: unexpected cc 0x1003 length: 249 > 9 [ 98.936291][ T958] Bluetooth: hci1: unexpected cc 0x1001 length: 249 > 9 [ 98.943854][ T959] Bluetooth: hci1: unexpected cc 0x0c23 length: 249 > 4 [ 98.951069][ T959] Bluetooth: hci1: unexpected cc 0x0c25 length: 249 > 3 [ 98.958170][ T959] Bluetooth: hci1: unexpected cc 0x0c38 length: 249 > 2 [ 99.012327][ T1880] chnl_net:caif_netlink_parms(): no params data found [ 99.470538][ T1880] 8021q: adding VLAN 0 to HW filter on device bond0 [ 99.756626][ T1880] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 99.763573][ T809] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 99.770965][ T809] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 101.020870][ T959] Bluetooth: hci1: command 0x0409 tx timeout [ 103.100844][ T959] Bluetooth: hci1: command 0x041b tx timeout [ 103.271259][ T849] udevd[849]: worker [1474] /devices/virtual/block/nbd0 is taking a long time [ 103.501073][ T463] block nbd0: Possible stuck request ffff8881013e8200: control (read@0,4096B). Runtime 60 seconds [ 105.180929][ T959] Bluetooth: hci1: command 0x040f tx timeout [ 107.260921][ T959] Bluetooth: hci1: command 0x0419 tx timeout [ 133.580979][ T463] block nbd0: Possible stuck request ffff8881013e8200: control (read@0,4096B). Runtime 90 seconds 2023/12/11 13:47:42 executed programs: 3 [ 156.278327][ T42] Bluetooth: hci2: unexpected cc 0x0c03 length: 249 > 1 [ 156.285393][ T958] Bluetooth: hci2: unexpected cc 0x1003 length: 249 > 9 [ 156.292448][ T958] Bluetooth: hci2: unexpected cc 0x1001 length: 249 > 9 [ 156.300077][ T958] Bluetooth: hci2: unexpected cc 0x0c23 length: 249 > 4 [ 156.307315][ T958] Bluetooth: hci2: unexpected cc 0x0c25 length: 249 > 3 [ 156.314401][ T958] Bluetooth: hci2: unexpected cc 0x0c38 length: 249 > 2 [ 156.366281][ T2282] chnl_net:caif_netlink_parms(): no params data found [ 156.780946][ T2282] 8021q: adding VLAN 0 to HW filter on device bond0 [ 157.055758][ T2282] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 157.062620][ T809] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 157.070110][ T809] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 158.380842][ T958] Bluetooth: hci2: command 0x0409 tx timeout [ 160.460859][ T958] Bluetooth: hci2: command 0x041b tx timeout [ 162.540906][ T959] Bluetooth: hci2: command 0x040f tx timeout [ 163.661245][ T463] block nbd0: Possible stuck request ffff8881013e8200: control (read@0,4096B). Runtime 120 seconds [ 164.460866][ T959] Bluetooth: hci0: command 0x0406 tx timeout [ 164.620877][ T959] Bluetooth: hci2: command 0x0419 tx timeout [ 193.741077][ T463] block nbd0: Possible stuck request ffff8881013e8200: control (read@0,4096B). Runtime 150 seconds [ 205.260898][ T28] INFO: task syz-executor.0:1877 blocked for more than 143 seconds. [ 205.269002][ T28] Not tainted 6.1.67-syzkaller #0 [ 205.274571][ T28] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 205.283315][ T28] task:syz-executor.0 state:D stack:14288 pid:1877 ppid:1473 flags:0x00004006 [ 205.292603][ T28] Call Trace: [ 205.295859][ T28] [ 205.298883][ T28] __schedule+0x57f/0x850 [ 205.303201][ T28] ? blkdev_put+0x4e/0x1a0 [ 205.307607][ T28] schedule+0x50/0xb0 [ 205.311751][ T28] schedule_preempt_disabled+0x2e/0x40 [ 205.317533][ T28] __mutex_lock+0x43b/0x940 [ 205.322117][ T28] blkdev_put+0x4e/0x1a0 [ 205.326339][ T28] blkdev_close+0xf/0x20 [ 205.330553][ T28] __fput+0xe1/0x210 [ 205.334443][ T28] task_work_run+0x79/0xa0 [ 205.338925][ T28] get_signal+0x62/0x7a0 [ 205.343161][ T28] arch_do_signal_or_restart+0x8c/0x7c0 [ 205.348771][ T28] ? nbd_ioctl+0x3e7/0x470 [ 205.353448][ T28] exit_to_user_mode_loop+0x61/0xc0 [ 205.358730][ T28] exit_to_user_mode_prepare+0x64/0xb0 [ 205.364179][ T28] syscall_exit_to_user_mode+0x27/0x1c0 [ 205.369836][ T28] do_syscall_64+0x49/0xb0 [ 205.374460][ T28] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 205.380329][ T28] RIP: 0033:0x7f1fc667c959 [ 205.384870][ T28] RSP: 002b:00007f1fc74530c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 [ 205.393259][ T28] RAX: 0000000000000000 RBX: 00007f1fc679bf80 RCX: 00007f1fc667c959 [ 205.401239][ T28] RDX: 0000000000000000 RSI: 000000000000ab03 RDI: 0000000000000003 [ 205.410258][ T28] RBP: 00007f1fc66d8c88 R08: 0000000000000000 R09: 0000000000000000 [ 205.418342][ T28] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 205.427040][ T28] R13: 0000000000000006 R14: 00007f1fc679bf80 R15: 00007ffe69c253f8 [ 205.435281][ T28] [ 205.438284][ T28] [ 205.438284][ T28] Showing all locks held in the system: [ 205.446433][ T28] 1 lock held by rcu_tasks_kthre/12: [ 205.451788][ T28] #0: ffffffff8357bf48 (rcu_tasks.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_kthread+0x98/0x450 [ 205.462448][ T28] 1 lock held by rcu_tasks_trace/13: [ 205.467801][ T28] #0: ffffffff8357c598 (rcu_tasks_trace.tasks_gp_mutex){....}-{3:3}, at: rcu_tasks_kthread+0x98/0x450 [ 205.478835][ T28] 1 lock held by khungtaskd/28: [ 205.483671][ T28] #0: ffffffff8357be20 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x2c/0x100 [ 205.493676][ T28] 2 locks held by getty/912: [ 205.498333][ T28] #0: ffff888101e43098 (&tty->ldisc_sem){....}-{0:0}, at: tty_ldisc_ref_wait+0x1c/0x40 [ 205.508156][ T28] #1: ffffc900018172f0 (&ldata->atomic_read_lock){....}-{3:3}, at: n_tty_read+0x20a/0x8e0 [ 205.518221][ T28] 1 lock held by udevd/1474: [ 205.522811][ T28] #0: ffff88810f6734c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev+0x9b/0x2f0 [ 205.532887][ T28] 1 lock held by syz-executor.0/1877: [ 205.538340][ T28] #0: ffff88810f6734c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_put+0x4e/0x1a0 [ 205.548122][ T28] 1 lock held by syz-executor.0/2279: [ 205.553659][ T28] #0: ffff88810f6734c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev+0x9b/0x2f0 [ 205.563557][ T28] 1 lock held by syz-executor.0/2682: [ 205.569076][ T28] #0: ffff88810f6734c8 (&disk->open_mutex){....}-{3:3}, at: blkdev_get_by_dev+0x9b/0x2f0 [ 205.579077][ T28] [ 205.581403][ T28] ============================================= [ 205.581403][ T28] [ 205.589991][ T28] NMI backtrace for cpu 1 [ 205.594313][ T28] CPU: 1 PID: 28 Comm: khungtaskd Not tainted 6.1.67-syzkaller #0 [ 205.602096][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 205.612240][ T28] Call Trace: [ 205.615599][ T28] [ 205.618856][ T28] dump_stack_lvl+0x7f/0xc2 [ 205.623507][ T28] nmi_cpu_backtrace+0x13e/0x160 [ 205.628516][ T28] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 205.634826][ T28] nmi_trigger_cpumask_backtrace+0x9c/0x150 [ 205.640804][ T28] watchdog+0x54d/0x570 [ 205.644929][ T28] ? watchdog+0xc9/0x570 [ 205.649136][ T28] ? hungtask_pm_notify+0x20/0x20 [ 205.654130][ T28] kthread+0xd1/0xe0 [ 205.658006][ T28] ? kthread_blkcg+0x30/0x30 [ 205.662559][ T28] ret_from_fork+0x1f/0x30 [ 205.666944][ T28] [ 205.669992][ T28] Sending NMI from CPU 1 to CPUs 0: [ 205.675302][ C0] NMI backtrace for cpu 0 [ 205.675306][ C0] CPU: 0 PID: 50 Comm: kworker/u4:2 Not tainted 6.1.67-syzkaller #0 [ 205.675310][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 205.675312][ C0] Workqueue: events_unbound toggle_allocation_gate [ 205.675319][ C0] RIP: 0010:preempt_count_sub+0x0/0x50 [ 205.675325][ C0] Code: db 31 ff e8 f2 f8 02 00 65 48 8b 05 fa b6 e8 7e 48 89 98 20 14 00 00 5b c3 e8 bc 41 79 00 eb be 66 2e 0f 1f 84 00 00 00 00 00 <83> 3d 99 12 97 03 00 75 22 65 8b 05 d8 b6 e8 7e 89 c1 81 e1 ff ff [ 205.675328][ C0] RSP: 0018:ffffc900003bfc98 EFLAGS: 00000046 [ 205.675331][ C0] RAX: 0000000000000001 RBX: ffffffff84c41390 RCX: 0000000000000000 [ 205.675333][ C0] RDX: 00000000ee672e55 RSI: ffffffff82f9e5c5 RDI: 0000000000000001 [ 205.675335][ C0] RBP: 00000000000064d8 R08: 0000000000000001 R09: 0000000000000000 [ 205.675336][ C0] R10: 0000000000000000 R11: 0000646e756f626e R12: 0000000000000086 [ 205.675339][ C0] R13: ffffc900003bfd90 R14: 0000000000000086 R15: ffffffff84c41390 [ 205.675340][ C0] FS: 0000000000000000(0000) GS:ffff888237c00000(0000) knlGS:0000000000000000 [ 205.675343][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 205.675345][ C0] CR2: 00007f6e1b7d02d8 CR3: 0000000003421000 CR4: 00000000003506f0 [ 205.675349][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 205.675351][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 205.675352][ C0] Call Trace: [ 205.675355][ C0] [ 205.675357][ C0] ? nmi_cpu_backtrace+0x108/0x160 [ 205.675365][ C0] ? nmi_cpu_backtrace_handler+0x8/0x10 [ 205.675370][ C0] ? nmi_handle+0x96/0x1b0 [ 205.675375][ C0] ? nmi_handle+0x25/0x1b0 [ 205.675378][ C0] ? preempt_count_add+0x80/0x80 [ 205.675381][ C0] ? default_do_nmi+0x62/0x150 [ 205.675388][ C0] ? exc_nmi+0xab/0x120 [ 205.675391][ C0] ? end_repeat_nmi+0x16/0x31 [ 205.675397][ C0] ? preempt_count_add+0x80/0x80 [ 205.675400][ C0] ? preempt_count_add+0x80/0x80 [ 205.675403][ C0] ? preempt_count_add+0x80/0x80 [ 205.675405][ C0] [ 205.675406][ C0] [ 205.675407][ C0] _raw_spin_unlock_irqrestore+0x5a/0xa0 [ 205.675411][ C0] debug_object_activate+0x1b3/0x2c0 [ 205.675417][ C0] __mod_timer+0x29d/0x370 [ 205.675422][ C0] ? process_one_work+0x1da/0x470 [ 205.675426][ C0] schedule_timeout+0x10e/0x190 [ 205.675433][ C0] ? update_process_times+0x80/0x80 [ 205.675437][ C0] toggle_allocation_gate+0xfd/0x230 [ 205.675440][ C0] ? wake_bit_function+0x70/0x70 [ 205.675444][ C0] process_one_work+0x235/0x470 [ 205.675449][ C0] worker_thread+0x214/0x370 [ 205.675452][ C0] ? process_one_work+0x470/0x470 [ 205.675455][ C0] kthread+0xd1/0xe0 [ 205.675460][ C0] ? kthread_blkcg+0x30/0x30 [ 205.675464][ C0] ret_from_fork+0x1f/0x30 [ 205.675472][ C0] [ 205.676297][ T28] Kernel panic - not syncing: hung_task: blocked tasks [ 205.961337][ T28] Kernel Offset: disabled [ 205.965900][ T28] Rebooting in 86400 seconds..