ci starts bisection 2023-01-31 05:20:16.788067213 +0000 UTC m=+727730.734129281
bisecting fixing commit since 6e764bcd1cf72a2846c0e53d3975a09b242c04c9
building syzkaller on b599f2fcc734e2183016a340d4f6fc2891d8e41f
ensuring issue is reproducible on original commit 6e764bcd1cf72a2846c0e53d3975a09b242c04c9
testing commit 6e764bcd1cf72a2846c0e53d3975a09b242c04c9 gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 4b13c99e4588d7697076ea73ea5619c15fccaf6251611bc480256e36d37efef5
all runs: crashed: INFO: task hung in pn533_finalize_setup
testing current HEAD c0b67534c95c537f7a506a06b98e5e85d72e2b7d
testing commit c0b67534c95c537f7a506a06b98e5e85d72e2b7d gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 737fe54032946255b70bd619cb1fa65c2e3639ea3dca13301563d27e3481bc5e
run #0: basic kernel testing failed: BUG: program execution failed: executor NUM: EOF
run #1: crashed: INFO: task hung in pn533_usb_send_frame
run #2: crashed: INFO: task hung in pn533_usb_send_frame
run #3: crashed: INFO: task hung in pn533_usb_send_frame
run #4: crashed: INFO: task hung in pn533_usb_send_frame
run #5: crashed: INFO: task hung in pn533_usb_send_frame
run #6: crashed: INFO: task hung in pn533_usb_send_frame
run #7: crashed: INFO: task hung in pn533_usb_send_frame
run #8: crashed: INFO: task hung in pn533_usb_send_frame
run #9: crashed: INFO: task hung in pn533_usb_send_frame
revisions tested: 2, total time: 26m59.16085585s (build: 14m58.226236963s, test: 10m50.461853985s)
the crash still happens on HEAD
commit msg: Merge tag 'cgroup-for-6.2-fixes' of git://git.kernel.org/pub/scm/linux/kernel/git/tj/cgroup
crash: INFO: task hung in pn533_usb_send_frame
INFO: task kworker/1:0:22 blocked for more than 143 seconds.
Not tainted 6.2.0-rc6-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:0 state:D stack:25176 pid:22 ppid:2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:5293 [inline]
__schedule+0x9f7/0x2890 kernel/sched/core.c:6606
schedule+0xde/0x1b0 kernel/sched/core.c:6682
schedule_timeout+0x1a3/0x260 kernel/time/timer.c:2143
do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common+0x1ce/0x5c0 kernel/sched/completion.c:106
pn533_usb_send_frame+0x2b0/0x540 drivers/nfc/pn533/usb.c:186
__pn533_send_async+0x1ea/0x550 drivers/nfc/pn533/pn533.c:462
pn533_send_cmd_async drivers/nfc/pn533/pn533.c:501 [inline]
pn533_send_cmd_sync drivers/nfc/pn533/pn533.c:624 [inline]
pn533_get_firmware_version drivers/nfc/pn533/pn533.c:2523 [inline]
pn533_finalize_setup+0xde/0x140 drivers/nfc/pn533/pn533.c:2720
pn533_usb_probe+0x84a/0xf10 drivers/nfc/pn533/usb.c:582
usb_probe_interface+0x278/0x6a0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:560 [inline]
really_probe+0x5a6/0xa50 drivers/base/dd.c:639
__driver_probe_device+0x186/0x460 drivers/base/dd.c:778
driver_probe_device+0x44/0x110 drivers/base/dd.c:808
__device_attach_driver+0x14e/0x270 drivers/base/dd.c:936
bus_for_each_drv+0x122/0x1a0 drivers/base/bus.c:427
__device_attach+0x19e/0x440 drivers/base/dd.c:1008
bus_probe_device+0x1a1/0x250 drivers/base/bus.c:487
device_add+0xa18/0x1b90 drivers/base/core.c:3479
usb_set_configuration+0xa05/0x18a0 drivers/usb/core/message.c:2171
usb_generic_driver_probe+0x78/0xa0 drivers/usb/core/generic.c:238
usb_probe_device+0x98/0x240 drivers/usb/core/driver.c:293
call_driver_probe drivers/base/dd.c:560 [inline]
really_probe+0x5a6/0xa50 drivers/base/dd.c:639
__driver_probe_device+0x186/0x460 drivers/base/dd.c:778
driver_probe_device+0x44/0x110 drivers/base/dd.c:808
__device_attach_driver+0x14e/0x270 drivers/base/dd.c:936
bus_for_each_drv+0x122/0x1a0 drivers/base/bus.c:427
__device_attach+0x19e/0x440 drivers/base/dd.c:1008
bus_probe_device+0x1a1/0x250 drivers/base/bus.c:487
device_add+0xa18/0x1b90 drivers/base/core.c:3479
usb_new_device.cold+0x600/0xf02 drivers/usb/core/hub.c:2576
hub_port_connect drivers/usb/core/hub.c:5408 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5552 [inline]
port_event drivers/usb/core/hub.c:5712 [inline]
hub_event+0x2450/0x3ce0 drivers/usb/core/hub.c:5794
process_one_work+0x8ba/0x14c0 kernel/workqueue.c:2289
worker_thread+0x59c/0xec0 kernel/workqueue.c:2436
kthread+0x298/0x340 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8b17df10 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8b17dc10 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
6 locks held by kworker/1:0/22:
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
#0: ffff888015cc1138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x7a0/0x14c0 kernel/workqueue.c:2260
#1: ffffc900001c7db8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7cf/0x14c0 kernel/workqueue.c:2264
#2: ffff88801eec1190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:831 [inline]
#2: ffff88801eec1190 (&dev->mutex){....}-{3:3}, at: hub_event+0x129/0x3ce0 drivers/usb/core/hub.c:5740
#3: ffff888076371190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:831 [inline]
#3: ffff888076371190 (&dev->mutex){....}-{3:3}, at: __device_attach+0x71/0x440 drivers/base/dd.c:983
#4: ffff88806e4f5118 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:831 [inline]
#4: ffff88806e4f5118 (&dev->mutex){....}-{3:3}, at: __device_attach+0x71/0x440 drivers/base/dd.c:983
#5: ffff88807c091438 (&priv->cmd_lock){+.+.}-{3:3}, at: __pn533_send_async+0x143/0x550 drivers/nfc/pn533/pn533.c:458
1 lock held by khungtaskd/28:
#0: ffffffff8b17ea60 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x57/0x264 kernel/locking/lockdep.c:6494
2 locks held by kworker/u4:2/38:
2 locks held by getty/4734:
#0: ffff8880253e1098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x23/0x80 drivers/tty/tty_ldisc.c:244
#1: ffffc900015b02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xb73/0x1040 drivers/tty/n_tty.c:2177
3 locks held by udevd/5529:
#0: ffff88802552b888 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:240 [inline]
#0: ffff88802552b888 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x163/0x6e0 fs/kernfs/file.c:280
#1: ffff888028e1f490 (kn->active#24){.+.+}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:241 [inline]
#1: ffff888028e1f490 (kn->active#24){.+.+}-{0:0}, at: kernfs_fop_read_iter+0x186/0x6e0 fs/kernfs/file.c:280
#2: ffff888076371190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:836 [inline]
#2: ffff888076371190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3a/0x310 drivers/usb/core/sysfs.c:874
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.2.0-rc6-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x5b/0x81 lib/dump_stack.c:106
nmi_cpu_backtrace.cold+0x18/0x106 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x259/0x2d0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:220 [inline]
watchdog+0x8c8/0xc60 kernel/hung_task.c:377
kthread+0x298/0x340 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 5508 Comm: syz-executor.0 Not tainted 6.2.0-rc6-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
RIP: 0010:should_fail_ex+0xed/0x5a0 lib/fault-inject.c:125
Code: 5b 5d 41 5c 41 5d 41 5e 41 5f c3 48 b8 00 00 00 00 00 fc ff df 48 89 da 48 c1 ea 03 80 3c 02 00 0f 85 fa 03 00 00 48 83 3b 00 <74> ce 48 8d 7b 20 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea
RSP: 0018:ffffc9000497fd98 EFLAGS: 00000246
RAX: dffffc0000000000 RBX: ffffffff8bac26c0 RCX: ffffc9000497fd60
RDX: 1ffffffff17584d8 RSI: 0000000000000001 RDI: ffff8880754194d4
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000001 R12: 0000000000000000
R13: ffff888075418000 R14: 0000000000000000 R15: ffffffff890ded30
FS: 0000000002805400(0000) GS:ffff8880b9f00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000002805708 CR3: 000000001f951000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
_copy_from_user+0x29/0xe0 lib/usercopy.c:14
copy_from_user include/linux/uaccess.h:161 [inline]
get_timespec64+0x6f/0x150 kernel/time/time.c:787
__do_sys_clock_nanosleep kernel/time/posix-timers.c:1266 [inline]
__se_sys_clock_nanosleep kernel/time/posix-timers.c:1254 [inline]
__x64_sys_clock_nanosleep+0x186/0x3b0 kernel/time/posix-timers.c:1254
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x39/0x80 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x48a811
Code: 24 0c 89 3c 24 48 89 4c 24 18 e8 aa e7 ff ff 4c 8b 54 24 18 48 8b 54 24 10 41 89 c0 8b 74 24 0c 8b 3c 24 b8 e6 00 00 00 0f 05 <44> 89 c7 48 89 04 24 e8 e3 e7 ff ff 48 8b 04 24 eb 97 66 2e 0f 1f
RSP: 002b:00007ffd9bb4b420 EFLAGS: 00000293 ORIG_RAX: 00000000000000e6
RAX: ffffffffffffffda RBX: 0000000000000351 RCX: 000000000048a811
RDX: 00007ffd9bb4b460 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007ffd9bb4b4fc R08: 0000000000000000 R09: 00007ffd9bb64080
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000032
R13: 00000000000389de R14: 0000000000000003 R15: 00007ffd9bb4b560