Warning: Permanently added '10.128.10.52' (ECDSA) to the list of known hosts. executing program [ 484.547249][ T27] audit: type=1400 audit(1664513645.701:75): avc: denied { execmem } for pid=3637 comm="syz-executor370" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=process permissive=1 [ 484.567447][ T27] audit: type=1400 audit(1664513645.701:76): avc: denied { read } for pid=3638 comm="syz-executor370" name="nbd0" dev="devtmpfs" ino=660 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [ 484.591718][ T27] audit: type=1400 audit(1664513645.701:77): avc: denied { open } for pid=3638 comm="syz-executor370" path="/dev/nbd0" dev="devtmpfs" ino=660 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [ 484.615876][ T27] audit: type=1400 audit(1664513645.701:78): avc: denied { ioctl } for pid=3638 comm="syz-executor370" path="/dev/nbd0" dev="devtmpfs" ino=660 ioctlcmd=0xab00 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [ 484.674077][ T3641] nbd0: detected capacity change from 0 to 128 [ 484.791354][ T3640] block nbd0: shutting down sockets [ 515.290494][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 30 seconds [ 544.760880][ T2975] udevd[2975]: worker [3643] /devices/virtual/block/nbd0 is taking a long time [ 545.370527][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 60 seconds [ 575.450561][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 90 seconds [ 605.530491][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 120 seconds [ 635.610546][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 150 seconds executing program [ 664.914806][ T2975] udevd[2975]: worker [3643] /devices/virtual/block/nbd0 timeout; kill it [ 664.923991][ T3643] ldm_validate_partition_table(): Disk read failed. [ 664.930897][ T2975] udevd[2975]: seq 7473 '/devices/virtual/block/nbd0' killed [ 664.931699][ T3643] Dev nbd0: unable to read RDB block 0 [ 664.944117][ T3643] nbd0: unable to read partition table [ 664.949767][ T3643] nbd0: partition table beyond EOD, truncated [ 665.690501][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 180 seconds [ 695.770511][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 210 seconds [ 725.850510][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 240 seconds [ 755.930544][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 270 seconds [ 786.010594][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 300 seconds [ 816.090567][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 330 seconds [ 846.170572][ T9] block nbd0: Possible stuck request ffff88801ea50000: control (read@0,4096B). Runtime 360 seconds [ 859.610641][ T28] INFO: task udevd:3643 blocked for more than 143 seconds. [ 859.618021][ T28] Not tainted 6.0.0-rc7-syzkaller-00130-g511cce163b75 #0 [ 859.626279][ T28] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 859.635943][ T28] task:udevd state:D stack:26248 pid: 3643 ppid: 2975 flags:0x00004006 [ 859.645379][ T28] Call Trace: [ 859.648682][ T28] [ 859.651823][ T28] __schedule+0xadf/0x52b0 [ 859.656408][ T28] ? io_schedule_timeout+0x140/0x140 [ 859.662033][ T28] ? mark_held_locks+0x9f/0xe0 [ 859.666817][ T28] schedule+0xda/0x1b0 [ 859.671092][ T28] io_schedule+0xba/0x130 [ 859.675442][ T28] folio_wait_bit_common+0x3dd/0xa90 [ 859.680933][ T28] ? perf_trace_mm_filemap_op_page_cache+0x8c0/0x8c0 [ 859.687635][ T28] ? __filemap_get_folio+0x250/0xed0 [ 859.693140][ T28] ? folio_unlock+0xc0/0xc0 [ 859.697676][ T28] __filemap_get_folio+0xc6d/0xed0 [ 859.702995][ T28] ? filemap_add_folio+0x1d0/0x1d0 [ 859.708129][ T28] ? page_cache_delete+0x850/0x850 [ 859.713422][ T28] ? _flat_send_IPI_mask+0x53/0x60 [ 859.718569][ T28] ? _flat_send_IPI_mask+0x53/0x60 [ 859.723940][ T28] truncate_inode_pages_range+0x37c/0x1510 [ 859.729771][ T28] ? truncate_inode_partial_folio+0xdf0/0xdf0 [ 859.736181][ T28] ? lockdep_hardirqs_on+0x79/0x100 [ 859.741472][ T28] ? smp_call_function_many_cond+0x642/0x1430 [ 859.747742][ T28] ? generic_remap_file_range_prep+0x50/0x50 [ 859.753916][ T28] ? __brelse+0xa0/0xa0 [ 859.758088][ T28] ? smp_call_on_cpu+0x270/0x270 [ 859.763216][ T28] ? mutex_lock_io_nested+0x1190/0x1190 [ 859.768790][ T28] ? __brelse+0xa0/0xa0 [ 859.773176][ T28] blkdev_flush_mapping+0x140/0x2f0 [ 859.778471][ T28] blkdev_put_whole+0xd1/0xf0 [ 859.783391][ T28] blkdev_put+0x226/0x770 [ 859.787742][ T28] blkdev_close+0x64/0x80 [ 859.792266][ T28] __fput+0x277/0x9d0 [ 859.796264][ T28] ? blkdev_fsync+0xa0/0xa0 [ 859.801126][ T28] task_work_run+0xdd/0x1a0 [ 859.805660][ T28] do_exit+0xad5/0x29b0 [ 859.809820][ T28] ? find_held_lock+0x2d/0x110 [ 859.814946][ T28] ? mm_update_next_owner+0x7a0/0x7a0 [ 859.820459][ T28] ? lock_downgrade+0x6e0/0x6e0 [ 859.825339][ T28] do_group_exit+0xd2/0x2f0 [ 859.829849][ T28] get_signal+0x238c/0x2610 [ 859.834766][ T28] ? exit_signals+0x8b0/0x8b0 [ 859.839463][ T28] ? kmem_cache_free.part.0+0x1d3/0x2e0 [ 859.845102][ T28] ? putname+0xfe/0x140 [ 859.849276][ T28] ? lockdep_hardirqs_on+0x79/0x100 [ 859.854811][ T28] arch_do_signal_or_restart+0x82/0x2300 [ 859.860518][ T28] ? do_sys_openat2+0xa1/0x4c0 [ 859.865302][ T28] ? build_open_flags+0x6f0/0x6f0 [ 859.870321][ T28] ? get_sigframe_size+0x10/0x10 [ 859.875326][ T28] ? up_write+0x470/0x470 [ 859.879679][ T28] ? __x64_sys_openat+0x13f/0x1f0 [ 859.884743][ T28] ? __ia32_sys_open+0x1c0/0x1c0 [ 859.889699][ T28] ? exit_to_user_mode_prepare+0x137/0x250 [ 859.895573][ T28] exit_to_user_mode_prepare+0x15f/0x250 [ 859.901238][ T28] syscall_exit_to_user_mode+0x19/0x50 [ 859.906692][ T28] do_syscall_64+0x42/0xb0 [ 859.911185][ T28] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 859.917148][ T28] RIP: 0033:0x7f3a60525697 [ 859.921591][ T28] RSP: 002b:00007ffe03f70f10 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 [ 859.930022][ T28] RAX: 0000000000000008 RBX: 0000562f9032c8a0 RCX: 00007f3a60525697 [ 859.938063][ T28] RDX: 00000000000a0800 RSI: 0000562f90326bf0 RDI: 00000000ffffff9c [ 859.946069][ T28] RBP: 0000562f90326bf0 R08: 0000000000000001 R09: 00007ffe03f88080 [ 859.954092][ T28] R10: 0000000000000000 R11: 0000000000000246 R12: 00000000000a0800 [ 859.962094][ T28] R13: 0000562f90313040 R14: 00007ffe03f70fbc R15: 0000562f902f72c0 [ 859.970064][ T28] [ 859.973173][ T28] INFO: task syz-executor370:3651 blocked for more than 143 seconds. [ 859.981277][ T28] Not tainted 6.0.0-rc7-syzkaller-00130-g511cce163b75 #0 [ 859.988833][ T28] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 859.997787][ T28] task:syz-executor370 state:D stack:28560 pid: 3651 ppid: 3637 flags:0x00000004 [ 860.007030][ T28] Call Trace: [ 860.010301][ T28] [ 860.013288][ T28] __schedule+0xadf/0x52b0 [ 860.017765][ T28] ? io_schedule_timeout+0x140/0x140 [ 860.023092][ T28] schedule+0xda/0x1b0 [ 860.027178][ T28] schedule_preempt_disabled+0xf/0x20 [ 860.032605][ T28] __mutex_lock+0xa44/0x1350 [ 860.037211][ T28] ? blkdev_get_by_dev.part.0+0x9b/0xb90 [ 860.042883][ T28] ? mutex_lock_io_nested+0x1190/0x1190 [ 860.048443][ T28] ? _atomic_dec_and_lock+0x92/0x100 [ 860.053861][ T28] ? disk_block_events+0x1d/0x130 [ 860.059001][ T28] blkdev_get_by_dev.part.0+0x9b/0xb90 [ 860.064526][ T28] ? devcgroup_check_permission+0x1a6/0x430 [ 860.070566][ T28] blkdev_get_by_dev+0x6b/0x80 [ 860.075335][ T28] blkdev_open+0x13c/0x2c0 [ 860.079750][ T28] do_dentry_open+0x4a4/0x13a0 [ 860.084554][ T28] ? blkdev_close+0x80/0x80 [ 860.089097][ T28] path_openat+0x1c92/0x28f0 [ 860.093752][ T28] ? path_lookupat+0x840/0x840 [ 860.098531][ T28] do_filp_open+0x1b6/0x400 [ 860.103099][ T28] ? may_open_dev+0xf0/0xf0 [ 860.107620][ T28] ? find_held_lock+0x2d/0x110 [ 860.112477][ T28] ? do_raw_spin_lock+0x120/0x2a0 [ 860.117524][ T28] ? rwlock_bug.part.0+0x90/0x90 [ 860.122515][ T28] ? _find_next_bit+0x1e3/0x260 [ 860.127408][ T28] ? _raw_spin_unlock+0x24/0x40 [ 860.132312][ T28] ? alloc_fd+0x2f0/0x6f0 [ 860.136661][ T28] do_sys_openat2+0x16d/0x4c0 [ 860.141372][ T28] ? build_open_flags+0x6f0/0x6f0 [ 860.146413][ T28] ? up_write+0x470/0x470 [ 860.150803][ T28] __x64_sys_openat+0x13f/0x1f0 [ 860.155673][ T28] ? __ia32_sys_open+0x1c0/0x1c0 [ 860.160643][ T28] ? syscall_enter_from_user_mode+0x22/0xb0 [ 860.166549][ T28] ? syscall_enter_from_user_mode+0x22/0xb0 [ 860.172552][ T28] do_syscall_64+0x35/0xb0 [ 860.176989][ T28] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 860.182919][ T28] RIP: 0033:0x7f757c7da9a4 [ 860.187342][ T28] RSP: 002b:00007f757c7cae70 EFLAGS: 00000293 ORIG_RAX: 0000000000000101 [ 860.196046][ T28] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f757c7da9a4 [ 860.204349][ T28] RDX: 0000000000000000 RSI: 00007f757c7caef0 RDI: 00000000ffffff9c [ 860.212665][ T28] RBP: 00007f757c7caef0 R08: 0000000000000000 R09: 00007f757c7cb700 [ 860.221054][ T28] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000 [ 860.229029][ T28] R13: 00007f757c86f074 R14: 64626e2f7665642f R15: 0000000000022000 [ 860.237675][ T28] [ 860.240891][ T28] [ 860.240891][ T28] Showing all locks held in the system: [ 860.248671][ T28] 1 lock held by rcu_tasks_kthre/12: [ 860.254263][ T28] #0: ffffffff8bf85db0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 [ 860.264905][ T28] 1 lock held by rcu_tasks_trace/13: [ 860.270181][ T28] #0: ffffffff8bf85ab0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 [ 860.281436][ T28] 1 lock held by khungtaskd/28: [ 860.286282][ T28] #0: ffffffff8bf86900 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 [ 860.296422][ T28] 2 locks held by getty/3281: [ 860.301287][ T28] #0: ffff88814b185098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 [ 860.311286][ T28] #1: ffffc90001c382f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xef0/0x13e0 [ 860.321565][ T28] 1 lock held by udevd/3643: [ 860.326147][ T28] #0: ffff88801e9b14c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xbc/0x770 [ 860.336322][ T28] 1 lock held by syz-executor370/3651: [ 860.342216][ T28] #0: ffff88801e9b14c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb90 [ 860.353380][ T28] 2 locks held by dhcpcd/3663: [ 860.358146][ T28] #0: ffff888026a4c130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x2f/0xdc0 [ 860.368180][ T28] #1: ffffffff8bf915b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x562/0x670 [ 860.379305][ T28] [ 860.381897][ T28] ============================================= [ 860.381897][ T28] [ 860.390325][ T28] NMI backtrace for cpu 1 [ 860.394647][ T28] CPU: 1 PID: 28 Comm: khungtaskd Not tainted 6.0.0-rc7-syzkaller-00130-g511cce163b75 #0 [ 860.404437][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/22/2022 [ 860.414482][ T28] Call Trace: [ 860.417749][ T28] [ 860.420668][ T28] dump_stack_lvl+0xcd/0x134 [ 860.425310][ T28] nmi_cpu_backtrace.cold+0x46/0x14f [ 860.430582][ T28] ? lapic_can_unplug_cpu+0x80/0x80 [ 860.435780][ T28] nmi_trigger_cpumask_backtrace+0x206/0x250 [ 860.441768][ T28] watchdog+0xc18/0xf50 [ 860.445916][ T28] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 860.451887][ T28] kthread+0x2e4/0x3a0 [ 860.455944][ T28] ? kthread_complete_and_exit+0x40/0x40 [ 860.461565][ T28] ret_from_fork+0x1f/0x30 [ 860.465969][ T28] [ 860.469078][ T28] Sending NMI from CPU 1 to CPUs 0: [ 860.474338][ C0] NMI backtrace for cpu 0 [ 860.474348][ C0] CPU: 0 PID: 11 Comm: kworker/u4:1 Not tainted 6.0.0-rc7-syzkaller-00130-g511cce163b75 #0 [ 860.474369][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/22/2022 [ 860.474381][ C0] Workqueue: events_unbound toggle_allocation_gate [ 860.474405][ C0] RIP: 0010:__default_send_IPI_dest_field+0x7c/0x130 [ 860.474432][ C0] Code: 00 c3 5f ff f6 c4 10 75 e2 44 89 e7 c1 e7 18 89 3c 25 10 c3 5f ff 89 f0 09 d8 80 cf 04 83 fe 02 0f 44 c3 89 04 25 00 c3 5f ff <48> 83 c4 08 5b 5d 41 5c c3 48 c7 c0 c0 0a a2 8b 48 ba 00 00 00 00 [ 860.474449][ C0] RSP: 0018:ffffc9000031f878 EFLAGS: 00000006 [ 860.474463][ C0] RAX: 00000000000008fb RBX: 0000000000000c00 RCX: 0000000000000001 [ 860.474474][ C0] RDX: 0000000000000800 RSI: 00000000000000fb RDI: 0000000002000000 [ 860.474486][ C0] RBP: fffffbffffebf860 R08: 0000000000000005 R09: 0000000000000001 [ 860.474497][ C0] R10: 0000000000000001 R11: 0000000000000000 R12: 0000000000000002 [ 860.474508][ C0] R13: ffffc9000031f8e0 R14: dffffc0000000000 R15: 0000000000000008 [ 860.474521][ C0] FS: 0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000 [ 860.474536][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 860.474549][ C0] CR2: 000056493b77c600 CR3: 000000000bc8e000 CR4: 00000000003506f0 [ 860.474561][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 860.474572][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 860.474584][ C0] Call Trace: [ 860.474588][ C0] [ 860.474594][ C0] ? trace_hardirqs_off+0xe/0x110 [ 860.474617][ C0] _flat_send_IPI_mask+0x4e/0x60 [ 860.474641][ C0] send_call_function_single_ipi+0x1b5/0x320 [ 860.474662][ C0] ? sched_ttwu_pending+0x550/0x550 [ 860.474681][ C0] ? llist_add_batch+0x6e/0xa0 [ 860.474699][ C0] smp_call_function_many_cond+0x113e/0x1430 [ 860.474723][ C0] ? optimize_nops+0x2d0/0x2d0 [ 860.474741][ C0] ? smp_call_on_cpu+0x270/0x270 [ 860.474762][ C0] ? text_poke_memset+0x60/0x60 [ 860.474778][ C0] ? optimize_nops+0x2d0/0x2d0 [ 860.474794][ C0] on_each_cpu_cond_mask+0x56/0xa0 [ 860.474816][ C0] text_poke_bp_batch+0x59e/0x6c0 [ 860.474833][ C0] ? kmem_cache_alloc_bulk+0x150/0x470 [ 860.474858][ C0] ? do_sync_core+0x20/0x20 [ 860.474875][ C0] ? __jump_label_update+0x296/0x410 [ 860.474894][ C0] text_poke_finish+0x16/0x30 [ 860.474912][ C0] arch_jump_label_transform_apply+0x13/0x20 [ 860.474941][ C0] jump_label_update+0x32f/0x410 [ 860.474960][ C0] static_key_enable_cpuslocked+0x1b1/0x260 [ 860.474979][ C0] static_key_enable+0x16/0x20 [ 860.474997][ C0] toggle_allocation_gate+0x100/0x390 [ 860.475017][ C0] ? lock_release+0x780/0x780 [ 860.475034][ C0] ? wake_up_kfence_timer+0x20/0x20 [ 860.475054][ C0] ? lockdep_hardirqs_on+0x79/0x100 [ 860.475072][ C0] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 860.475092][ C0] process_one_work+0x991/0x1610 [ 860.475114][ C0] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 860.475135][ C0] ? rwlock_bug.part.0+0x90/0x90 [ 860.475153][ C0] ? _raw_spin_lock_irq+0x41/0x50 [ 860.475173][ C0] worker_thread+0x665/0x1080 [ 860.475194][ C0] ? process_one_work+0x1610/0x1610 [ 860.475214][ C0] kthread+0x2e4/0x3a0 [ 860.475231][ C0] ? kthread_complete_and_exit+0x40/0x40 [ 860.475251][ C0] ret_from_fork+0x1f/0x30 [ 860.475273][ C0] [ 860.475377][ T28] Kernel panic - not syncing: hung_task: blocked tasks [ 860.807600][ T28] CPU: 1 PID: 28 Comm: khungtaskd Not tainted 6.0.0-rc7-syzkaller-00130-g511cce163b75 #0 [ 860.817406][ T28] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/22/2022 [ 860.827480][ T28] Call Trace: [ 860.830804][ T28] [ 860.833742][ T28] dump_stack_lvl+0xcd/0x134 [ 860.838342][ T28] panic+0x2c8/0x627 [ 860.842279][ T28] ? panic_print_sys_info.part.0+0x10b/0x10b [ 860.848312][ T28] ? lapic_can_unplug_cpu+0x80/0x80 [ 860.853549][ T28] ? preempt_schedule_thunk+0x16/0x18 [ 860.858929][ T28] ? watchdog.cold+0x130/0x158 [ 860.863717][ T28] watchdog.cold+0x141/0x158 [ 860.868309][ T28] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 860.874294][ T28] kthread+0x2e4/0x3a0 [ 860.878364][ T28] ? kthread_complete_and_exit+0x40/0x40 [ 860.884005][ T28] ret_from_fork+0x1f/0x30 [ 860.888428][ T28] [ 860.891745][ T28] Kernel Offset: disabled [ 860.896079][ T28] Rebooting in 86400 seconds..