Warning: Permanently added '10.128.10.25' (ED25519) to the list of known hosts. 2023/12/02 03:34:01 ignoring optional flag "sandboxArg"="0" 2023/12/02 03:34:01 parsed 1 programs 2023/12/02 03:34:01 executed programs: 0 [ 45.426904][ T2560] veth0_vlan: entered promiscuous mode [ 45.724955][ T2788] loop0: detected capacity change from 0 to 65536 [ 45.733236][ T2788] XFS (loop0): Deprecated V4 format (crc=0) will not be supported after September 2030. [ 45.744225][ T2788] XFS (loop0): Mounting V4 Filesystem 5e6273b8-2167-42bb-911b-418aa14a1261 [ 45.753620][ T2788] XFS (loop0): totally zeroed log [ 45.759633][ T2788] XFS (loop0): Ending clean mount [ 45.765330][ T2788] XFS (loop0): Quotacheck needed: Please wait. [ 45.773774][ T2788] XFS (loop0): Quotacheck: Done. [ 45.778892][ T2788] xfs filesystem being mounted at /root/syzkaller-testdir2625914896/syzkaller.2TI6QB/0/file0 supports timestamps until 2038-01-19 (0x7fffffff) [ 45.796090][ T2788] syz-executor.0: attempt to access beyond end of device [ 45.796090][ T2788] loop0: rw=432129, sector=65536, nr_sectors = 64 limit=65536 [ 45.810984][ T340] XFS (loop0): log I/O error -5 [ 45.815818][ T340] XFS (loop0): Filesystem has been shut down due to log error (0x2). [ 45.823919][ T340] XFS (loop0): Please unmount the filesystem and rectify the problem(s). 2023/12/02 03:34:57 executed programs: 1 [ 102.128461][ T2799] veth0_vlan: entered promiscuous mode 2023/12/02 03:35:02 executed programs: 23 2023/12/02 03:35:07 executed programs: 56 2023/12/02 03:35:12 executed programs: 90 2023/12/02 03:35:17 executed programs: 124 2023/12/02 03:35:22 executed programs: 158 2023/12/02 03:35:27 executed programs: 192 2023/12/02 03:35:32 executed programs: 226 2023/12/02 03:35:37 executed programs: 259 2023/12/02 03:35:43 executed programs: 292 2023/12/02 03:35:48 executed programs: 326 2023/12/02 03:35:53 executed programs: 360 2023/12/02 03:35:58 executed programs: 393 2023/12/02 03:36:03 executed programs: 426 2023/12/02 03:36:08 executed programs: 458 2023/12/02 03:36:13 executed programs: 491 2023/12/02 03:36:18 executed programs: 525 2023/12/02 03:36:23 executed programs: 558 [ 189.420511][ T29] INFO: task kworker/0:1H:340 blocked for more than 143 seconds. [ 189.428509][ T29] Not tainted 6.7.0-rc3-syzkaller #0 [ 189.434347][ T29] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 189.443202][ T29] task:kworker/0:1H state:D stack:14488 pid:340 tgid:340 ppid:2 flags:0x00004000 [ 189.453518][ T29] Workqueue: xfs-log/loop0 xlog_ioend_work [ 189.459314][ T29] Call Trace: [ 189.462606][ T29] [ 189.465704][ T29] __schedule+0x67b/0x980 [ 189.470023][ T29] ? schedule+0x20/0x100 [ 189.474340][ T29] schedule+0xab/0x100 [ 189.478626][ T29] schedule_timeout+0x88/0x190 [ 189.483400][ T29] __down_common+0xee/0x230 [ 189.487970][ T29] down+0x3c/0x40 [ 189.491638][ T29] ? xfs_buf_item_unpin+0x85/0x1d0 [ 189.496828][ T29] xfs_buf_lock+0x4f/0x120 [ 189.501422][ T29] xfs_buf_item_unpin+0x85/0x1d0 [ 189.506429][ T29] xfs_trans_committed_bulk+0x133/0x2c0 [ 189.512067][ T29] xlog_cil_committed+0x93/0x1a0 [ 189.516988][ T29] xlog_cil_process_committed+0x5c/0x80 [ 189.522534][ T29] xlog_state_shutdown_callbacks+0x4b/0x110 [ 189.528954][ T29] xlog_force_shutdown+0x138/0x160 [ 189.534051][ T29] ? process_scheduled_works+0x1f2/0x4d0 [ 189.539757][ T29] xlog_ioend_work+0x43/0x70 [ 189.544369][ T29] process_scheduled_works+0x24c/0x4d0 [ 189.549820][ T29] worker_thread+0x23d/0x300 [ 189.554410][ T29] ? pr_cont_work+0x190/0x190 [ 189.559176][ T29] kthread+0xe5/0x100 [ 189.563154][ T29] ? kthread_blkcg+0x30/0x30 [ 189.567731][ T29] ret_from_fork+0x2e/0x40 [ 189.572159][ T29] ? kthread_blkcg+0x30/0x30 [ 189.576748][ T29] ret_from_fork_asm+0x11/0x20 [ 189.581514][ T29] [ 189.586586][ T29] INFO: task syz-executor.0:2788 blocked for more than 143 seconds. [ 189.594965][ T29] Not tainted 6.7.0-rc3-syzkaller #0 [ 189.601421][ T29] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 189.610421][ T29] task:syz-executor.0 state:D stack:13048 pid:2788 tgid:2787 ppid:2560 flags:0x00004006 [ 189.620934][ T29] Call Trace: [ 189.624229][ T29] [ 189.627155][ T29] __schedule+0x67b/0x980 [ 189.631674][ T29] ? schedule+0x20/0x100 [ 189.636498][ T29] schedule+0xab/0x100 [ 189.640669][ T29] xlog_wait_on_iclog+0x14a/0x1b0 [ 189.645768][ T29] ? do_task_dead+0x40/0x40 [ 189.650341][ T29] xlog_force_lsn+0x249/0x250 [ 189.655040][ T29] xfs_log_force_seq+0xab/0x170 [ 189.659879][ T29] __xfs_trans_commit+0x2b3/0x3d0 [ 189.665014][ T29] xfs_sync_sb_buf+0x6a/0xb0 [ 189.669628][ T29] xfs_file_ioctl+0x460/0xc70 [ 189.674567][ T29] ? smk_tskacc+0xc6/0xe0 [ 189.679233][ T29] ? smack_file_ioctl+0xac/0x100 [ 189.684606][ T29] __se_sys_ioctl+0x6d/0xb0 [ 189.689270][ T29] do_syscall_64+0x45/0x110 [ 189.693777][ T29] entry_SYSCALL_64_after_hwframe+0x63/0x6b [ 189.700000][ T29] RIP: 0033:0x7f49e50528d9 [ 189.704543][ T29] RSP: 002b:00007f49e4bd50c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 [ 189.713042][ T29] RAX: ffffffffffffffda RBX: 00007f49e5171f80 RCX: 00007f49e50528d9 [ 189.721114][ T29] RDX: 0000000020000000 RSI: 0000000041009432 RDI: 0000000000000004 [ 189.729477][ T29] RBP: 00007f49e50aead0 R08: 0000000000000000 R09: 0000000000000000 [ 189.737554][ T29] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 189.745526][ T29] R13: 000000000000000b R14: 00007f49e5171f80 R15: 00007fff9c1369d8 [ 189.753605][ T29] [ 189.756770][ T29] [ 189.756770][ T29] Showing all locks held in the system: [ 189.764673][ T29] 1 lock held by khungtaskd/29: [ 189.769857][ T29] #0: ffffffff82f86e80 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x30/0x100 [ 189.779995][ T29] 2 locks held by kworker/0:1H/340: [ 189.785384][ T29] #0: ffff88810e32cb38 ((wq_completion)xfs-log/loop0){....}-{0:0}, at: process_scheduled_works+0x1f2/0x4d0 [ 189.797198][ T29] #1: ffffc90000e97e58 ((work_completion)(&iclog->ic_end_io_work)){....}-{0:0}, at: process_scheduled_works+0x1f2/0x4d0 [ 189.810911][ T29] 2 locks held by kworker/u4:4/1425: [ 189.816258][ T29] #0: ffff88810006ad38 ((wq_completion)events_unbound){....}-{0:0}, at: process_scheduled_works+0x1f2/0x4d0 [ 189.828254][ T29] #1: ffffc90006107e58 (connector_reaper_work){....}-{0:0}, at: process_scheduled_works+0x1f2/0x4d0 [ 189.840354][ T29] 2 locks held by getty/2160: [ 189.845124][ T29] #0: ffff888105a630a0 (&tty->ldisc_sem){....}-{0:0}, at: tty_ldisc_ref_wait+0x20/0x40 [ 189.855285][ T29] #1: ffffc90006e7b2f0 (&ldata->atomic_read_lock){....}-{3:3}, at: n_tty_read+0x242/0x910 [ 189.865495][ T29] 1 lock held by syz-executor.0/2788: [ 189.870961][ T29] #0: ffff88811032e3f0 (sb_writers#14){....}-{0:0}, at: xfs_file_ioctl+0x403/0xc70 [ 189.880418][ T29] 3 locks held by syz-executor.0/4178: [ 189.886644][ T29] [ 189.889038][ T29] ============================================= [ 189.889038][ T29] [ 189.898024][ T29] NMI backtrace for cpu 0 [ 189.902596][ T29] CPU: 0 PID: 29 Comm: khungtaskd Not tainted 6.7.0-rc3-syzkaller #0 [ 189.911242][ T29] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 189.921804][ T29] Call Trace: [ 189.925153][ T29] [ 189.928139][ T29] dump_stack_lvl+0x83/0xd0 [ 189.932887][ T29] nmi_cpu_backtrace+0x142/0x160 [ 189.938160][ T29] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 189.944385][ T29] nmi_trigger_cpumask_backtrace+0x8e/0x140 [ 189.950254][ T29] watchdog+0x5da/0x600 [ 189.954481][ T29] ? watchdog+0xcd/0x600 [ 189.958795][ T29] ? hungtask_pm_notify+0x30/0x30 [ 189.963976][ T29] kthread+0xe5/0x100 [ 189.968110][ T29] ? kthread_blkcg+0x30/0x30 [ 189.972766][ T29] ret_from_fork+0x2e/0x40 [ 189.977598][ T29] ? kthread_blkcg+0x30/0x30 [ 189.982344][ T29] ret_from_fork_asm+0x11/0x20 [ 189.987179][ T29] [ 189.990318][ T29] Sending NMI from CPU 0 to CPUs 1: [ 189.995718][ C1] NMI backtrace for cpu 1 [ 189.995722][ C1] CPU: 1 PID: 4180 Comm: syz-executor.0 Not tainted 6.7.0-rc3-syzkaller #0 [ 189.995726][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/10/2023 [ 189.995728][ C1] RIP: 0033:0x7f664ea5c8ab [ 189.995732][ C1] Code: cd 48 01 c1 49 39 4f 08 72 4c 8d 4d ff 85 ed 74 33 66 0f 1f 44 00 00 48 39 f0 72 1b 4d 8b 07 49 89 c1 49 29 f1 47 0f b6 0c 08 <45> 84 c9 74 08 45 88 0c 00 49 8b 47 10 48 83 c0 01 49 89 47 10 83 [ 189.995735][ C1] RSP: 002b:00007f664e632520 EFLAGS: 00000202 [ 189.995738][ C1] RAX: 0000000000130a52 RBX: 00007f664e6325c0 RCX: 00000000000000b9 [ 189.995740][ C1] RDX: 0000000000000000 RSI: 0000000000000001 RDI: 00007f664e632660 [ 189.995742][ C1] RBP: 0000000000000102 R08: 00007f6646213000 R09: 0000000000000000 [ 189.995744][ C1] R10: 0000000000000000 R11: 00007f664e6325d0 R12: 0000000000000001 [ 189.995745][ C1] R13: 00007f664eb1dce0 R14: 0000000000000000 R15: 00007f664e632660 [ 189.995747][ C1] FS: 00007f664e6336c0 GS: 0000000000000000 [ 189.996715][ T29] Kernel panic - not syncing: hung_task: blocked tasks [ 190.105200][ T29] Kernel Offset: disabled [ 190.109501][ T29] Rebooting in 86400 seconds..