./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor4043436633 <...> Warning: Permanently added '10.128.1.96' (ED25519) to the list of known hosts. execve("./syz-executor4043436633", ["./syz-executor4043436633"], 0x7ffff27b4a50 /* 10 vars */) = 0 brk(NULL) = 0x555584ffe000 brk(0x555584ffed00) = 0x555584ffed00 arch_prctl(ARCH_SET_FS, 0x555584ffe380) = 0 set_tid_address(0x555584ffe650) = 5848 set_robust_list(0x555584ffe660, 24) = 0 rseq(0x555584ffeca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor4043436633", 4096) = 28 getrandom("\xd9\x4f\xcf\x0d\x11\xdc\x92\xbd", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555584ffed00 brk(0x55558501fd00) = 0x55558501fd00 brk(0x555585020000) = 0x555585020000 mprotect(0x7f965c69d000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5849 attached , child_tidptr=0x555584ffe650) = 5849 [pid 5849] set_robust_list(0x555584ffe660, 24 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5849] <... set_robust_list resumed>) = 0 [pid 5849] mkdir("./syzkaller.TNaOaC", 0700./strace-static-x86_64: Process 5850 attached [pid 5850] set_robust_list(0x555584ffe660, 24 [pid 5848] <... clone resumed>, child_tidptr=0x555584ffe650) = 5850 [pid 5849] <... mkdir resumed>) = 0 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5850] <... set_robust_list resumed>) = 0 [pid 5849] chmod("./syzkaller.TNaOaC", 0777 [pid 5850] mkdir("./syzkaller.LpOw0P", 0700 [pid 5849] <... chmod resumed>) = 0 ./strace-static-x86_64: Process 5851 attached [pid 5851] set_robust_list(0x555584ffe660, 24 [pid 5848] <... clone resumed>, child_tidptr=0x555584ffe650) = 5851 [pid 5851] <... set_robust_list resumed>) = 0 [pid 5849] chdir("./syzkaller.TNaOaC") = 0 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5851] mkdir("./syzkaller.sm6V7b", 0700 [pid 5850] <... mkdir resumed>) = 0 [pid 5849] mkdir("./0", 0777) = 0 ./strace-static-x86_64: Process 5852 attached [pid 5851] <... mkdir resumed>) = 0 [pid 5850] chmod("./syzkaller.LpOw0P", 0777 [pid 5852] set_robust_list(0x555584ffe660, 24 [pid 5849] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5848] <... clone resumed>, child_tidptr=0x555584ffe650) = 5852 [pid 5852] <... set_robust_list resumed>) = 0 [pid 5851] chmod("./syzkaller.sm6V7b", 0777 [pid 5850] <... chmod resumed>) = 0 [pid 5849] <... openat resumed>) = 3 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5852] mkdir("./syzkaller.JjWBiB", 0700 [pid 5851] <... chmod resumed>) = 0 [pid 5850] chdir("./syzkaller.LpOw0P" [pid 5849] ioctl(3, LOOP_CLR_FD [pid 5851] chdir("./syzkaller.sm6V7b" [pid 5850] <... chdir resumed>) = 0 ./strace-static-x86_64: Process 5853 attached [pid 5851] <... chdir resumed>) = 0 [pid 5850] mkdir("./0", 0777 [pid 5848] <... clone resumed>, child_tidptr=0x555584ffe650) = 5853 [pid 5853] set_robust_list(0x555584ffe660, 24 [pid 5851] mkdir("./0", 0777 [pid 5850] <... mkdir resumed>) = 0 [pid 5849] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5853] <... set_robust_list resumed>) = 0 [pid 5852] <... mkdir resumed>) = 0 [pid 5851] <... mkdir resumed>) = 0 [pid 5849] close(3 [pid 5850] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5851] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5853] mkdir("./syzkaller.UHHzks", 0700 [pid 5852] chmod("./syzkaller.JjWBiB", 0777 [pid 5850] <... openat resumed>) = 3 [pid 5849] <... close resumed>) = 0 [pid 5852] <... chmod resumed>) = 0 [pid 5851] <... openat resumed>) = 3 [pid 5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5852] chdir("./syzkaller.JjWBiB" [pid 5850] ioctl(3, LOOP_CLR_FD./strace-static-x86_64: Process 5855 attached [pid 5853] <... mkdir resumed>) = 0 [pid 5852] <... chdir resumed>) = 0 [pid 5851] ioctl(3, LOOP_CLR_FD [pid 5850] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5849] <... clone resumed>, child_tidptr=0x555584ffe650) = 5855 [pid 5855] set_robust_list(0x555584ffe660, 24 [pid 5853] chmod("./syzkaller.UHHzks", 0777 [pid 5850] close(3 [pid 5855] <... set_robust_list resumed>) = 0 [pid 5853] <... chmod resumed>) = 0 [pid 5852] mkdir("./0", 0777 [pid 5851] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5850] <... close resumed>) = 0 [pid 5855] chdir("./0" [pid 5852] <... mkdir resumed>) = 0 [pid 5851] close(3 [pid 5853] chdir("./syzkaller.UHHzks" [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5855] <... chdir resumed>) = 0 [pid 5853] <... chdir resumed>) = 0 [pid 5851] <... close resumed>) = 0 [pid 5851] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5856 attached [pid 5855] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5853] mkdir("./0", 0777 [pid 5852] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5852] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5852] close(3 [pid 5851] <... clone resumed>, child_tidptr=0x555584ffe650) = 5857 ./strace-static-x86_64: Process 5857 attached [pid 5856] set_robust_list(0x555584ffe660, 24 [pid 5855] <... prctl resumed>) = 0 [pid 5853] <... mkdir resumed>) = 0 [pid 5852] <... close resumed>) = 0 [pid 5850] <... clone resumed>, child_tidptr=0x555584ffe650) = 5856 [pid 5857] set_robust_list(0x555584ffe660, 24 [pid 5856] <... set_robust_list resumed>) = 0 [pid 5855] setpgid(0, 0 [pid 5857] <... set_robust_list resumed>) = 0 [pid 5855] <... setpgid resumed>) = 0 [pid 5857] chdir("./0" [pid 5855] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5852] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5857] <... chdir resumed>) = 0 [pid 5856] chdir("./0" [pid 5855] <... openat resumed>) = 3 [pid 5853] openat(AT_FDCWD, "/dev/loop4", O_RDWR./strace-static-x86_64: Process 5858 attached [pid 5857] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5856] <... chdir resumed>) = 0 [pid 5857] <... prctl resumed>) = 0 [pid 5858] set_robust_list(0x555584ffe660, 24 [pid 5857] setpgid(0, 0 [pid 5856] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5852] <... clone resumed>, child_tidptr=0x555584ffe650) = 5858 [pid 5858] <... set_robust_list resumed>) = 0 [pid 5857] <... setpgid resumed>) = 0 [pid 5856] <... prctl resumed>) = 0 [pid 5855] write(3, "1000", 4 [pid 5853] <... openat resumed>) = 3 [pid 5858] chdir("./0") = 0 [pid 5857] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5856] setpgid(0, 0 [pid 5855] <... write resumed>) = 4 [pid 5858] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5856] <... setpgid resumed>) = 0 [pid 5855] close(3 [pid 5853] ioctl(3, LOOP_CLR_FD [pid 5858] <... prctl resumed>) = 0 [pid 5857] <... openat resumed>) = 3 [pid 5856] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5855] <... close resumed>) = 0 [pid 5858] setpgid(0, 0) = 0 [pid 5857] write(3, "1000", 4 [pid 5858] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5857] <... write resumed>) = 4 [pid 5857] close(3) = 0 [pid 5857] symlink("/dev/binderfs", "./binderfs" [pid 5858] <... openat resumed>) = 3 [pid 5857] <... symlink resumed>) = 0 [pid 5858] write(3, "1000", 4) = 4 [pid 5858] close(3) = 0 [pid 5858] symlink("/dev/binderfs", "./binderfs") = 0 executing program executing program executing program [pid 5858] write(1, "executing program\n", 18 [pid 5857] write(1, "executing program\n", 18 [pid 5856] <... openat resumed>) = 3 [pid 5855] symlink("/dev/binderfs", "./binderfs" [pid 5853] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5855] <... symlink resumed>) = 0 [pid 5858] <... write resumed>) = 18 [pid 5855] write(1, "executing program\n", 18 [pid 5858] memfd_create("syzkaller", 0 [pid 5855] <... write resumed>) = 18 [pid 5857] <... write resumed>) = 18 [pid 5856] write(3, "1000", 4 [pid 5853] close(3 [pid 5856] <... write resumed>) = 4 [pid 5853] <... close resumed>) = 0 [pid 5856] close(3 [pid 5853] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5859 attached [pid 5857] memfd_create("syzkaller", 0 [pid 5856] <... close resumed>) = 0 [pid 5855] memfd_create("syzkaller", 0 [pid 5858] <... memfd_create resumed>) = 3 [pid 5856] symlink("/dev/binderfs", "./binderfs" [pid 5855] <... memfd_create resumed>) = 3 [pid 5858] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5857] <... memfd_create resumed>) = 3 [pid 5856] <... symlink resumed>) = 0 [pid 5855] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5858] <... mmap resumed>) = 0x7f9654000000 executing program [pid 5857] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5853] <... clone resumed>, child_tidptr=0x555584ffe650) = 5859 [pid 5859] set_robust_list(0x555584ffe660, 24 [pid 5855] <... mmap resumed>) = 0x7f9654000000 [pid 5856] write(1, "executing program\n", 18) = 18 [pid 5856] memfd_create("syzkaller", 0 [pid 5857] <... mmap resumed>) = 0x7f9654000000 [pid 5856] <... memfd_create resumed>) = 3 [pid 5856] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5859] <... set_robust_list resumed>) = 0 [pid 5856] <... mmap resumed>) = 0x7f9654000000 [pid 5859] chdir("./0") = 0 [pid 5859] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5859] setpgid(0, 0) = 0 [pid 5859] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5859] write(3, "1000", 4) = 4 [pid 5859] close(3) = 0 [pid 5859] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5859] write(1, "executing program\n", 18executing program ) = 18 [pid 5859] memfd_create("syzkaller", 0) = 3 [pid 5859] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f9654000000 [pid 5855] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5857] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5858] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5856] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5859] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5855] <... write resumed>) = 16777216 [pid 5855] munmap(0x7f9654000000, 138412032) = 0 [pid 5855] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5855] ioctl(4, LOOP_SET_FD, 3 [pid 5858] <... write resumed>) = 16777216 [pid 5856] <... write resumed>) = 16777216 [pid 5855] <... ioctl resumed>) = 0 [pid 5856] munmap(0x7f9654000000, 138412032 [pid 5858] munmap(0x7f9654000000, 138412032 [pid 5855] close(3) = 0 [pid 5856] <... munmap resumed>) = 0 [pid 5855] close(4) = 0 [pid 5856] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5855] mkdir("./file0", 0777 [ 233.842817][ T5855] loop0: detected capacity change from 0 to 32768 [pid 5856] ioctl(4, LOOP_SET_FD, 3 [pid 5858] <... munmap resumed>) = 0 [pid 5855] <... mkdir resumed>) = 0 [pid 5856] <... ioctl resumed>) = 0 [pid 5855] mount("/dev/loop0", "./file0", "jfs", MS_I_VERSION, "" [pid 5859] <... write resumed>) = 16777216 [pid 5858] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5856] close(3 [pid 5858] <... openat resumed>) = 4 [pid 5859] munmap(0x7f9654000000, 138412032 [pid 5858] ioctl(4, LOOP_SET_FD, 3 [pid 5856] <... close resumed>) = 0 [pid 5856] close(4) = 0 [pid 5856] mkdir("./file0", 0777) = 0 [pid 5856] mount("/dev/loop1", "./file0", "jfs", MS_I_VERSION, "" [pid 5858] <... ioctl resumed>) = 0 [pid 5858] close(3) = 0 [pid 5858] close(4) = 0 [pid 5857] <... write resumed>) = 16777216 [pid 5858] mkdir("./file0", 0777) = 0 [pid 5858] mount("/dev/loop3", "./file0", "jfs", MS_I_VERSION, "" [pid 5857] munmap(0x7f9654000000, 138412032 [pid 5855] <... mount resumed>) = 0 [pid 5855] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5855] chdir("./file0") = 0 [pid 5856] <... mount resumed>) = 0 [pid 5855] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5859] <... munmap resumed>) = 0 [pid 5856] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5855] <... openat resumed>) = -1 EBUSY (Device or resource busy) [ 233.889912][ T5856] loop1: detected capacity change from 0 to 32768 [ 233.913689][ T5858] loop3: detected capacity change from 0 to 32768 [pid 5856] <... openat resumed>) = 3 [pid 5855] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5856] chdir("./file0") = 0 [pid 5856] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5856] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [pid 5856] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5859] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5857] <... munmap resumed>) = 0 [pid 5855] <... openat resumed>) = 4 [pid 5859] <... openat resumed>) = 4 [pid 5855] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5859] ioctl(4, LOOP_SET_FD, 3 [pid 5857] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 4 [pid 5857] ioctl(4, LOOP_SET_FD, 3 [pid 5859] <... ioctl resumed>) = 0 [pid 5857] <... ioctl resumed>) = 0 [ 233.971086][ T5856] ERROR: (device loop1): diWrite: ixpxd invalid [ 233.971086][ T5856] [ 233.985508][ T5855] ERROR: (device loop0): diWrite: ixpxd invalid [ 233.985508][ T5855] [ 233.986947][ T5857] loop2: detected capacity change from 0 to 32768 [ 233.995340][ T5859] loop4: detected capacity change from 0 to 32768 [ 234.003628][ T5856] ERROR: (device loop1): remounting filesystem as read-only [pid 5859] close(3 [pid 5857] close(3 [pid 5859] <... close resumed>) = 0 [pid 5858] <... mount resumed>) = 0 [pid 5857] <... close resumed>) = 0 [pid 5859] close(4 [pid 5858] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5857] close(4 [pid 5856] <... openat resumed>) = -1 EIO (Input/output error) [pid 5859] <... close resumed>) = 0 [pid 5858] <... openat resumed>) = 3 [pid 5857] <... close resumed>) = 0 [pid 5858] chdir("./file0" [pid 5859] mkdir("./file0", 0777 [pid 5857] mkdir("./file0", 0777 [pid 5856] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5857] <... mkdir resumed>) = 0 [pid 5857] mount("/dev/loop2", "./file0", "jfs", MS_I_VERSION, "" [pid 5859] <... mkdir resumed>) = 0 [pid 5859] mount("/dev/loop4", "./file0", "jfs", MS_I_VERSION, "" [pid 5858] <... chdir resumed>) = 0 [pid 5858] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5856] <... write resumed>) = 24 [pid 5856] exit_group(0 [pid 5858] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5856] <... exit_group resumed>) = ? [pid 5856] +++ exited with 0 +++ [pid 5858] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5856, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=25 /* 0.25 s */} --- [pid 5850] restart_syscall(<... resuming interrupted clone ...> [pid 5858] <... openat resumed>) = 4 [ 234.017110][ T5855] ERROR: (device loop0): remounting filesystem as read-only [ 234.026960][ T5856] ERROR: (device loop1): txCommit: [ 234.026960][ T5856] [ 234.036737][ T5855] ERROR: (device loop0): txCommit: [ 234.036737][ T5855] [pid 5858] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5857] <... mount resumed>) = 0 [pid 5857] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5857] chdir("./file0") = 0 [pid 5857] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5857] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [pid 5857] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5850] <... restart_syscall resumed>) = 0 [pid 5850] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5850] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5850] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5855] <... openat resumed>) = -1 EIO (Input/output error) [pid 5850] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] unlink("./0/binderfs" [pid 5855] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5850] <... unlink resumed>) = 0 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5855] <... write resumed>) = 24 [pid 5855] exit_group(0) = ? [pid 5855] +++ exited with 0 +++ [pid 5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5855, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=24 /* 0.24 s */} --- [pid 5859] <... mount resumed>) = 0 [pid 5859] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5849] restart_syscall(<... resuming interrupted clone ...> [pid 5859] <... openat resumed>) = 3 [pid 5859] chdir("./file0") = 0 [pid 5849] <... restart_syscall resumed>) = 0 [pid 5859] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5849] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5859] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5859] <... openat resumed>) = 4 [ 234.072446][ T5857] ERROR: (device loop2): diWrite: ixpxd invalid [ 234.072446][ T5857] [ 234.079114][ T5858] ERROR: (device loop3): diWrite: ixpxd invalid [ 234.079114][ T5858] [ 234.093294][ T5858] ERROR: (device loop3): remounting filesystem as read-only [ 234.112816][ T5857] ERROR: (device loop2): remounting filesystem as read-only [pid 5859] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5849] <... openat resumed>) = 3 [pid 5849] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] getdents64(3, 0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5849] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] unlink("./0/binderfs") = 0 [pid 5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5857] <... openat resumed>) = -1 EIO (Input/output error) [pid 5858] <... openat resumed>) = -1 EIO (Input/output error) [pid 5857] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24) = 24 [pid 5857] exit_group(0) = ? [pid 5858] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5857] +++ exited with 0 +++ [pid 5851] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5857, si_uid=0, si_status=0, si_utime=10 /* 0.10 s */, si_stime=29 /* 0.29 s */} --- [pid 5859] <... openat resumed>) = -1 EIO (Input/output error) [pid 5858] <... write resumed>) = 24 [pid 5851] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5859] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5858] exit_group(0) = ? [pid 5851] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5851] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5851] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5851] getdents64(3, [pid 5858] +++ exited with 0 +++ [pid 5851] <... getdents64 resumed>0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5852] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5858, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=26 /* 0.26 s */} --- [pid 5851] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] restart_syscall(<... resuming interrupted clone ...> [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] unlink("./0/binderfs" [pid 5859] <... write resumed>) = 24 [pid 5851] <... unlink resumed>) = 0 [pid 5859] exit_group(0 [pid 5851] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5859] <... exit_group resumed>) = ? [pid 5859] +++ exited with 0 +++ [pid 5853] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5859, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=23 /* 0.23 s */} --- [pid 5853] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5852] <... restart_syscall resumed>) = 0 [pid 5853] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5853] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5852] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5853] <... openat resumed>) = 3 [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5853] newfstatat(3, "", [pid 5852] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5853] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5852] <... openat resumed>) = 3 [pid 5853] getdents64(3, [pid 5852] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5852] getdents64(3, 0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5852] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5853] <... getdents64 resumed>0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5853] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5853] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5853] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5852] unlink("./0/binderfs" [pid 5853] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5852] <... unlink resumed>) = 0 [pid 5853] unlink("./0/binderfs" [pid 5852] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5853] <... unlink resumed>) = 0 [ 234.126467][ T5859] ERROR: (device loop4): diWrite: ixpxd invalid [ 234.126467][ T5859] [ 234.128394][ T5857] ERROR: (device loop2): txCommit: [ 234.128394][ T5857] [ 234.138716][ T5858] ERROR: (device loop3): txCommit: [ 234.138716][ T5858] [ 234.156042][ T5859] ERROR: (device loop4): remounting filesystem as read-only [ 234.164002][ T5859] ERROR: (device loop4): txCommit: [ 234.164002][ T5859] [ 286.108897][ T5850] jfs_flush_journal: synclist not empty [ 286.114617][ T5850] metapage: ffff888031911c98: 00001000 00000000 000036c8 00000000 [ 286.122623][ T5850] metapage: ffff888031911ca8: 27e33a28 ffff8880 27e33a28 ffff8880 [ 286.130624][ T5850] metapage: ffff888031911cb8: 00000004 00000000 00000000 00000000 [ 286.138468][ T5850] metapage: ffff888031911cc8: 76584000 ffff8880 0000001c 00000000 [ 286.146354][ T5850] metapage: ffff888031911cd8: 00000000 dead4ead ffffffff 00000000 [ 286.154250][ T5850] metapage: ffff888031911ce8: ffffffff ffffffff 9a4c3520 ffffffff [ 286.154281][ T5849] jfs_flush_journal: synclist not empty [ 286.162153][ T5850] metapage: ffff888031911cf8: 93c40518 ffffffff 00000000 00000000 [ 286.162178][ T5850] metapage: ffff888031911d08: 8c425fa0 ffffffff 00000300 00000000 [ 286.162198][ T5850] metapage: ffff888031911d18: 31911d18 ffff8880 31911d18 ffff8880 [ 286.167789][ T5849] metapage: ffff8880284e3d90: 00001000 00000000 000036c8 00000000 [ 286.175563][ T5850] metapage: ffff888031911d28: 01d96100 ffffea00 7ae26000 ffff8880 [ 286.184283][ T5851] jfs_flush_journal: synclist not empty [ 286.191240][ T5850] metapage: ffff888031911d38: 00001000 00003794 00000001 00000000 [ 286.191261][ T5850] metapage: ffff888031911d48: 27e33800 ffff8880 [ 286.199738][ T5853] jfs_flush_journal: synclist not empty [ 286.206969][ T5850] page: ffffea0001d96100: 00fff0000000412c ffffea0001d97008 [ 286.213204][ T5849] metapage: ffff8880284e3da0: 27129a28 ffff8880 27129a28 ffff8880 [ 286.220402][ T5850] page: ffffea0001d96110: ffffea0001d60108 ffff8880737e8650 [ 286.220422][ T5850] page: ffffea0001d96120: 000000000000001c ffff888031911c98 [ 286.220436][ T5850] page: ffffea0001d96130: 00000003ffffffff ffff888140adc000 [ 286.224934][ T5851] metapage: ffff888074c9eaa8: 00001000 00000000 000036c8 00000000 [ 286.227382][ T5852] jfs_flush_journal: synclist not empty [ 286.232349][ T5851] metapage: ffff888074c9eab8: 27e34228 ffff8880 27e34228 ffff8880 [ 286.239790][ T5849] metapage: ffff8880284e3db0: 00000004 00000000 00000000 00000000 [ 286.254805][ T5851] metapage: ffff888074c9eac8: 00000004 00000000 00000000 00000000 [ 286.254830][ T5851] metapage: ffff888074c9ead8: 76e6d000 ffff8880 0000001c 00000000 [ 286.254846][ T5851] metapage: ffff888074c9eae8: 00000000 dead4ead ffffffff 00000000 [ 286.254864][ T5851] metapage: ffff888074c9eaf8: ffffffff ffffffff 9a4c3520 ffffffff [ 286.254889][ T5851] metapage: ffff888074c9eb08: 93c40518 ffffffff 00000000 00000000 [ 286.263230][ T5849] metapage: ffff8880284e3dc0: 76cfe000 ffff8880 0000001c 00000000 [ 286.269756][ T5853] metapage: ffff8880306488b8: 00001000 00000000 000036c8 00000000 [ 286.277840][ T5849] metapage: ffff8880284e3dd0: 00000000 dead4ead ffffffff 00000000 [ 286.283103][ T5852] metapage: ffff88802f79cba0: 00001000 00000000 000036c8 00000000 [ 286.291114][ T5849] metapage: ffff8880284e3de0: ffffffff ffffffff 9a4c3520 ffffffff [ 286.298598][ T5853] metapage: ffff8880306488c8: 7afb7228 ffff8880 7afb7228 ffff8880 [ 286.306801][ T5849] metapage: ffff8880284e3df0: 93c40518 ffffffff 00000000 00000000 [ 286.314349][ T5851] metapage: ffff888074c9eb18: 8c425fa0 ffffffff 00000300 00000000 [ 286.314371][ T5851] metapage: ffff888074c9eb28: 74c9eb28 ffff8880 74c9eb28 ffff8880 [ 286.346107][ T5849] metapage: ffff8880284e3e00: 8c425fa0 ffffffff 00000300 00000000 [ 286.353553][ T5852] metapage: ffff88802f79cbb0: 7afb5228 ffff8880 7afb5228 ffff8880 [ 286.369230][ T5849] metapage: ffff8880284e3e10: 284e3e10 ffff8880 284e3e10 ffff8880 [ 286.377040][ T5853] metapage: ffff8880306488d8: 00000004 00000000 00000000 00000000 [ 286.386311][ T5849] metapage: ffff8880284e3e20: 01db3f80 ffffea00 7cd92000 ffff8880 [ 286.393705][ T5853] metapage: ffff8880306488e8: 3489f000 ffff8880 0000001c 00000000 [ 286.401941][ T5849] metapage: ffff8880284e3e30: 00001000 00003794 00000001 00000000 [ 286.409390][ T5852] metapage: ffff88802f79cbc0: 00000004 00000000 00000000 00000000 [ 286.417413][ T5851] metapage: ffff888074c9eb38: 01db9b40 ffffea00 76cac000 ffff8880 [ 286.425007][ T5853] metapage: ffff8880306488f8: 00000000 dead4ead ffffffff 00000000 [ 286.433243][ T5849] metapage: ffff8880284e3e40: 27129800 ffff8880 [ 286.440800][ T5852] metapage: ffff88802f79cbd0: 75a7a000 ffff8880 0000001c 00000000 [ 286.449089][ T5851] metapage: ffff888074c9eb48: 00001000 00003794 00000001 00000000 [ 286.456585][ T5853] metapage: ffff888030648908: ffffffff ffffffff 9a4c3520 ffffffff [ 286.464386][ T5849] page: ffffea0001db3f80: 00fff0000000412c ffffea0001db8cc8 [ 286.472222][ T5852] metapage: ffff88802f79cbe0: 00000000 dead4ead ffffffff 00000000 [ 286.480515][ T5851] metapage: ffff888074c9eb58: 27e34000 ffff8880 [ 286.487867][ T5852] metapage: ffff88802f79cbf0: ffffffff ffffffff 9a4c3520 ffffffff [ 286.502317][ T5849] page: ffffea0001db3f90: ffffea0001d96108 ffff8880737e0650 [ 286.509882][ T5853] metapage: ffff888030648918: 93c40518 ffffffff 00000000 00000000 [ 286.525279][ T5849] page: ffffea0001db3fa0: 000000000000001c ffff8880284e3d90 [ 286.532768][ T5852] metapage: ffff88802f79cc00: 93c40518 ffffffff 00000000 00000000 [ 286.532790][ T5852] metapage: ffff88802f79cc10: 8c425fa0 ffffffff 00000300 00000000 [ 286.539046][ T5851] page: ffffea0001db9b40: 00fff0000000412c ffffea0001db9b08 [ 286.546834][ T5853] metapage: ffff888030648928: 8c425fa0 ffffffff 00000300 00000000 [ 286.562032][ T5849] page: ffffea0001db3fb0: 00000003ffffffff ffff888140adc000 [ 286.562289][ T5851] page: ffffea0001db9b50: ffffea0001d68388 ffff8880735b0f88 [ 286.569407][ T5852] metapage: ffff88802f79cc20: 2f79cc20 ffff8880 2f79cc20 ffff8880 [ 286.569428][ T5852] metapage: ffff88802f79cc30: 01d69e80 ffffea00 7b792000 ffff8880 [ 286.592816][ T5851] page: ffffea0001db9b60: 000000000000001c ffff888074c9eaa8 [ 286.600480][ T5853] metapage: ffff888030648938: 30648938 ffff8880 30648938 ffff8880 [ 286.609505][ T5851] page: ffffea0001db9b70: 00000003ffffffff ffff888140adc000 [ 286.615146][ T5853] metapage: ffff888030648948: 00d227c0 ffffea00 30734000 ffff8880 [ 286.626387][ T5852] metapage: ffff88802f79cc40: 00001000 00003794 00000001 00000000 [ 286.630654][ T5853] metapage: ffff888030648958: 00001000 00003794 00000001 00000000 [ 286.630672][ T5853] metapage: ffff888030648968: 7afb7000 ffff8880 [ 286.630690][ T5853] page: ffffea0000d227c0: 00fff0000000412c ffffea0001d32508 [ 286.630706][ T5853] page: ffffea0000d227d0: ffffea0001db13c8 ffff8880735b18c0 [ 286.638261][ T5852] metapage: ffff88802f79cc50: 7afb5000 ffff8880 [ 286.645819][ T5853] page: ffffea0000d227e0: 000000000000001c ffff8880306488b8 [ 286.645837][ T5853] page: ffffea0000d227f0: 00000003ffffffff ffff888140adc000 [ 286.653167][ T5852] page: ffffea0001d69e80: 00fff0000000412c ffffea0001d69e08 [ 286.726242][ T5852] page: ffffea0001d69e90: ffffea0001db9b48 ffff8880737e3468 [ 286.733609][ T5852] page: ffffea0001d69ea0: 000000000000001c ffff88802f79cba0 [ 286.740997][ T5852] page: ffffea0001d69eb0: 00000003ffffffff ffff888140adc000 [ 338.248867][ T5850] jfs_flush_journal: synclist not empty [ 338.254665][ T5850] metapage: ffff888031911c98: 00001000 00000000 000036c8 00000000 [ 338.262602][ T5850] metapage: ffff888031911ca8: 27e33a28 ffff8880 27e33a28 ffff8880 [ 338.270712][ T5850] metapage: ffff888031911cb8: 00000004 00000000 00000000 00000000 [ 338.279365][ T5850] metapage: ffff888031911cc8: 76584000 ffff8880 0000001c 00000000 [ 338.287317][ T5850] metapage: ffff888031911cd8: 00000000 dead4ead ffffffff 00000000 [ 338.295244][ T5850] metapage: ffff888031911ce8: ffffffff ffffffff 9a4c3520 ffffffff [ 338.303114][ T5850] metapage: ffff888031911cf8: 93c40518 ffffffff 00000000 00000000 [ 338.311006][ T5850] metapage: ffff888031911d08: 8c425fa0 ffffffff 00000300 00000000 [ 338.318870][ T5850] metapage: ffff888031911d18: 31911d18 ffff8880 31911d18 ffff8880 [ 338.326969][ T5850] metapage: ffff888031911d28: 01d96100 ffffea00 7ae26000 ffff8880 [ 338.334881][ T5850] metapage: ffff888031911d38: 00001000 00003794 00000001 00000000 [ 338.342749][ T5850] metapage: ffff888031911d48: 27e33800 ffff8880 [pid 5853] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... umount2 resumed>) = 0 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [ 338.349036][ T5850] page: ffffea0001d96100: 00fff0000000412c ffffea0001db3f88 [ 338.356362][ T5850] page: ffffea0001d96110: ffffea0001d60108 ffff8880737e8650 [ 338.363761][ T5850] page: ffffea0001d96120: 000000000000001c ffff888031911c98 [ 338.371120][ T5850] page: ffffea0001d96130: 00000003ffffffff ffff888140adc000 [pid 5850] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5850] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(4, 0x555585007730 /* 2 entries */, 32768) = 48 [pid 5850] getdents64(4, 0x555585007730 /* 0 entries */, 32768) = 0 [pid 5850] close(4) = 0 [pid 5850] rmdir("./0/file0") = 0 [pid 5850] getdents64(3, 0x555584fff6f0 /* 0 entries */, 32768) = 0 [pid 5850] close(3) = 0 [pid 5850] rmdir("./0") = 0 [pid 5850] mkdir("./1", 0777) = 0 [pid 5850] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5850] ioctl(3, LOOP_CLR_FD) = 0 [pid 5850] close(3) = 0 [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5863 attached , child_tidptr=0x555584ffe650) = 5863 [pid 5863] set_robust_list(0x555584ffe660, 24) = 0 [pid 5863] chdir("./1") = 0 [pid 5863] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5863] setpgid(0, 0) = 0 [pid 5863] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5863] write(3, "1000", 4) = 4 [pid 5863] close(3) = 0 [pid 5863] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5863] write(1, "executing program\n", 18executing program ) = 18 [pid 5863] memfd_create("syzkaller", 0) = 3 [pid 5863] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f9654000000 [pid 5863] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216) = 16777216 [pid 5863] munmap(0x7f9654000000, 138412032) = 0 [pid 5863] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5863] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5863] close(3) = 0 [pid 5863] close(4) = 0 [pid 5863] mkdir("./file0", 0777) = 0 [ 338.895529][ T5863] loop1: detected capacity change from 0 to 32768 [pid 5863] mount("/dev/loop1", "./file0", "jfs", MS_I_VERSION, "") = 0 [pid 5863] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5863] chdir("./file0") = 0 [pid 5863] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5863] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [pid 5863] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error) [pid 5863] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24) = 24 [pid 5863] exit_group(0) = ? [pid 5863] +++ exited with 0 +++ [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5863, si_uid=0, si_status=0, si_utime=1 /* 0.01 s */, si_stime=16 /* 0.16 s */} --- [ 338.991368][ T5863] ERROR: (device loop1): diWrite: ixpxd invalid [ 338.991368][ T5863] [ 339.000740][ T5863] ERROR: (device loop1): remounting filesystem as read-only [ 339.008073][ T5863] ERROR: (device loop1): txCommit: [ 339.008073][ T5863] [pid 5850] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5850] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5850] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5850] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] unlink("./1/binderfs") = 0 [ 390.398865][ T5849] jfs_flush_journal: synclist not empty [ 390.405038][ T5849] metapage: ffff8880284e3d90: 00001000 00000000 000036c8 00000000 [ 390.412978][ T5849] metapage: ffff8880284e3da0: 27129a28 ffff8880 27129a28 ffff8880 [ 390.420995][ T5849] metapage: ffff8880284e3db0: 00000004 00000000 00000000 00000000 [ 390.429156][ T5849] metapage: ffff8880284e3dc0: 76cfe000 ffff8880 0000001c 00000000 [ 390.437000][ T5849] metapage: ffff8880284e3dd0: 00000000 dead4ead ffffffff 00000000 [ 390.445122][ T5849] metapage: ffff8880284e3de0: ffffffff ffffffff 9a4c3520 ffffffff [ 390.453026][ T5849] metapage: ffff8880284e3df0: 93c40518 ffffffff 00000000 00000000 [ 390.461101][ T5849] metapage: ffff8880284e3e00: 8c425fa0 ffffffff 00000300 00000000 [ 390.469171][ T5849] metapage: ffff8880284e3e10: 284e3e10 ffff8880 284e3e10 ffff8880 [ 390.476999][ T5849] metapage: ffff8880284e3e20: 01db3f80 ffffea00 7cd92000 ffff8880 [ 390.484884][ T5849] metapage: ffff8880284e3e30: 00001000 00003794 00000001 00000000 [ 390.492883][ T5849] metapage: ffff8880284e3e40: 27129800 ffff8880 [pid 5850] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... umount2 resumed>) = 0 [pid 5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [ 390.499301][ T5849] page: ffffea0001db3f80: 00fff0000000412c ffffea0001c19608 [ 390.506817][ T5849] page: ffffea0001db3f90: ffffea0001d96108 ffff8880737e0650 [ 390.514444][ T5849] page: ffffea0001db3fa0: 000000000000001c ffff8880284e3d90 [ 390.521830][ T5849] page: ffffea0001db3fb0: 00000003ffffffff ffff888140adc000 [pid 5849] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5849] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] getdents64(4, 0x555585007730 /* 2 entries */, 32768) = 48 [pid 5849] getdents64(4, 0x555585007730 /* 0 entries */, 32768) = 0 [pid 5849] close(4) = 0 [pid 5849] rmdir("./0/file0") = 0 [pid 5849] getdents64(3, 0x555584fff6f0 /* 0 entries */, 32768) = 0 [pid 5849] close(3) = 0 [pid 5849] rmdir("./0") = 0 [pid 5849] mkdir("./1", 0777) = 0 [pid 5849] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 3 [pid 5849] ioctl(3, LOOP_CLR_FD) = 0 [pid 5849] close(3) = 0 [pid 5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5872 attached , child_tidptr=0x555584ffe650) = 5872 [pid 5872] set_robust_list(0x555584ffe660, 24) = 0 [pid 5872] chdir("./1") = 0 [pid 5872] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5872] setpgid(0, 0) = 0 [pid 5872] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5872] write(3, "1000", 4) = 4 [pid 5872] close(3) = 0 [pid 5872] symlink("/dev/binderfs", "./binderfs") = 0 executing program [pid 5872] write(1, "executing program\n", 18) = 18 [pid 5872] memfd_create("syzkaller", 0) = 3 [pid 5872] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f9654000000 [pid 5872] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216) = 16777216 [pid 5872] munmap(0x7f9654000000, 138412032) = 0 [pid 5872] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5872] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5872] close(3) = 0 [pid 5872] close(4) = 0 [pid 5872] mkdir("./file0", 0777) = 0 [pid 5872] mount("/dev/loop0", "./file0", "jfs", MS_I_VERSION, "") = 0 [pid 5872] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5872] chdir("./file0") = 0 [pid 5872] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = -1 EBUSY (Device or resource busy) [ 391.050085][ T5872] loop0: detected capacity change from 0 to 32768 [pid 5872] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [pid 5872] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error) [pid 5872] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24) = 24 [ 391.119945][ T5872] ERROR: (device loop0): diWrite: ixpxd invalid [ 391.119945][ T5872] [ 391.129173][ T5872] ERROR: (device loop0): remounting filesystem as read-only [ 391.136514][ T5872] ERROR: (device loop0): txCommit: [ 391.136514][ T5872] [pid 5872] exit_group(0) = ? [pid 5872] +++ exited with 0 +++ [pid 5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5872, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=12 /* 0.12 s */} --- [pid 5849] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5849] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5849] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5849] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] getdents64(3, 0x555584fff6f0 /* 4 entries */, 32768) = 112 [pid 5849] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] unlink("./1/binderfs") = 0 [ 391.168798][ T5850] jfs_flush_journal: synclist not empty [ 391.174457][ T5850] metapage: ffff888026101d90: 00001000 00000000 000036c8 00000000 [ 391.182571][ T5850] metapage: ffff888026101da0: 7afb4228 ffff8880 7afb4228 ffff8880 [ 391.190553][ T5850] metapage: ffff888026101db0: 00000004 00000000 00000000 00000000 [ 391.198413][ T5850] metapage: ffff888026101dc0: 75b14000 ffff8880 0000001c 00000000 [ 391.206505][ T5850] metapage: ffff888026101dd0: 00000000 dead4ead ffffffff 00000000 [ 391.214600][ T5850] metapage: ffff888026101de0: ffffffff ffffffff 9a4c3520 ffffffff [ 391.222798][ T5850] metapage: ffff888026101df0: 93c40518 ffffffff 00000000 00000000 [ 391.230739][ T5850] metapage: ffff888026101e00: 8c425fa0 ffffffff 00000300 00000000 [ 391.238582][ T5850] metapage: ffff888026101e10: 26101e10 ffff8880 26101e10 ffff8880 [ 391.246512][ T5850] metapage: ffff888026101e20: 01d6c500 ffffea00 223a4000 ffff8880 [ 391.254778][ T5850] metapage: ffff888026101e30: 00001000 00003794 00000001 00000000 [ 391.262776][ T5850] metapage: ffff888026101e40: 7afb4000 ffff8880 [ 391.269120][ T5850] page: ffffea0001d6c500: 00fff0000000412c ffffea0001d6c588 [ 391.276676][ T5850] page: ffffea0001d6c510: ffffea0001bfbec8 ffff8880735b74f0 [ 391.284117][ T5850] page: ffffea0001d6c520: 000000000000001c ffff888026101d90 [ 391.291530][ T5850] page: ffffea0001d6c530: 00000003ffffffff ffff888140adc000 [ 430.118966][ T30] INFO: task syz-executor404:5852 blocked for more than 143 seconds. [ 430.127193][ T30] Not tainted 6.13.0-rc7-syzkaller-00189-g595523945be0 #0 [ 430.134977][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 430.143713][ T30] task:syz-executor404 state:D stack:25472 pid:5852 tgid:5852 ppid:5848 flags:0x00004002 [ 430.154644][ T30] Call Trace: [ 430.157959][ T30] [ 430.161030][ T30] __schedule+0x17fb/0x4be0 [ 430.165692][ T30] ? __pfx___schedule+0x10/0x10 [ 430.170662][ T30] ? __pfx_lock_release+0x10/0x10 [ 430.175712][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 430.181686][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.187656][ T30] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 430.194095][ T30] ? schedule+0x90/0x320 [ 430.198367][ T30] schedule+0x14b/0x320 [ 430.202720][ T30] schedule_preempt_disabled+0x13/0x30 [ 430.208207][ T30] __mutex_lock+0x7e7/0xee0 [ 430.212804][ T30] ? __mutex_lock+0x5ef/0xee0 [ 430.217537][ T30] ? lmLogClose+0xb2/0x530 [ 430.222032][ T30] ? __pfx___mutex_lock+0x10/0x10 [ 430.227091][ T30] ? updateSuper+0x13d/0x760 [ 430.231814][ T30] lmLogClose+0xb2/0x530 [ 430.236188][ T30] jfs_umount+0x2ce/0x3a0 [ 430.240610][ T30] jfs_put_super+0x8a/0x190 [ 430.245233][ T30] ? __pfx_jfs_put_super+0x10/0x10 [ 430.250445][ T30] generic_shutdown_super+0x139/0x2d0 [ 430.255841][ T30] kill_block_super+0x44/0x90 [ 430.260584][ T30] deactivate_locked_super+0xc4/0x130 [ 430.266002][ T30] cleanup_mnt+0x41f/0x4b0 [ 430.270551][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 430.275812][ T30] task_work_run+0x24f/0x310 [ 430.280473][ T30] ? __pfx_task_work_run+0x10/0x10 [ 430.285626][ T30] ? path_umount+0x211/0xf80 [ 430.290328][ T30] ptrace_notify+0x2d2/0x380 [ 430.294943][ T30] ? user_path_at+0x44/0x60 [ 430.299560][ T30] ? __pfx_ptrace_notify+0x10/0x10 [ 430.304729][ T30] ? kmem_cache_free+0x195/0x410 [ 430.309874][ T30] ? __x64_sys_umount+0x123/0x170 [ 430.314943][ T30] syscall_exit_work+0xc7/0x1d0 [ 430.319936][ T30] syscall_exit_to_user_mode+0x24a/0x340 [ 430.325604][ T30] do_syscall_64+0x100/0x230 [ 430.330280][ T30] ? clear_bhb_loop+0x35/0x90 [ 430.334980][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.340952][ T30] RIP: 0033:0x7f965c6254f7 [ 430.345423][ T30] RSP: 002b:00007fff4bc5f658 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6 [ 430.354652][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f965c6254f7 [ 430.362768][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fff4bc5f710 [ 430.370869][ T30] RBP: 00007fff4bc5f710 R08: 0000000000000000 R09: 0000000000000000 [ 430.379026][ T30] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007fff4bc60770 [ 430.387028][ T30] R13: 0000555584fff6c0 R14: 0000000000000001 R15: 431bde82d7b634db [ 430.395903][ T30] [ 430.399283][ T30] INFO: task syz-executor404:5853 blocked for more than 143 seconds. [ 430.407458][ T30] Not tainted 6.13.0-rc7-syzkaller-00189-g595523945be0 #0 [ 430.415189][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 430.424166][ T30] task:syz-executor404 state:D stack:25400 pid:5853 tgid:5853 ppid:5848 flags:0x00004002 [ 430.435652][ T30] Call Trace: [ 430.439144][ T30] [ 430.442134][ T30] __schedule+0x17fb/0x4be0 [ 430.446699][ T30] ? __pfx___schedule+0x10/0x10 [ 430.451674][ T30] ? __pfx_lock_release+0x10/0x10 [ 430.456740][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 430.462750][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.468908][ T30] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 430.475276][ T30] ? schedule+0x90/0x320 [ 430.479607][ T30] schedule+0x14b/0x320 [ 430.483815][ T30] schedule_preempt_disabled+0x13/0x30 [ 430.489379][ T30] __mutex_lock+0x7e7/0xee0 [ 430.493917][ T30] ? __mutex_lock+0x5ef/0xee0 [ 430.498603][ T30] ? lmLogClose+0xb2/0x530 [ 430.503078][ T30] ? __pfx___mutex_lock+0x10/0x10 [ 430.508242][ T30] ? updateSuper+0x13d/0x760 [ 430.512945][ T30] lmLogClose+0xb2/0x530 [ 430.517221][ T30] jfs_umount+0x2ce/0x3a0 [ 430.521722][ T30] jfs_put_super+0x8a/0x190 [ 430.526259][ T30] ? __pfx_jfs_put_super+0x10/0x10 [ 430.531471][ T30] generic_shutdown_super+0x139/0x2d0 [ 430.536870][ T30] kill_block_super+0x44/0x90 [ 430.541624][ T30] deactivate_locked_super+0xc4/0x130 [ 430.547036][ T30] cleanup_mnt+0x41f/0x4b0 [ 430.551653][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 430.556894][ T30] task_work_run+0x24f/0x310 [ 430.561554][ T30] ? __pfx_task_work_run+0x10/0x10 [ 430.567595][ T30] ? path_umount+0x211/0xf80 [ 430.572361][ T30] ptrace_notify+0x2d2/0x380 [ 430.577097][ T30] ? user_path_at+0x44/0x60 [ 430.581684][ T30] ? __pfx_ptrace_notify+0x10/0x10 [ 430.586840][ T30] ? kmem_cache_free+0x195/0x410 [ 430.591896][ T30] ? __x64_sys_umount+0x123/0x170 [ 430.596968][ T30] syscall_exit_work+0xc7/0x1d0 [ 430.602227][ T30] syscall_exit_to_user_mode+0x24a/0x340 [ 430.607904][ T30] do_syscall_64+0x100/0x230 [ 430.612604][ T30] ? clear_bhb_loop+0x35/0x90 [ 430.617317][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.623290][ T30] RIP: 0033:0x7f965c6254f7 [ 430.627742][ T30] RSP: 002b:00007fff4bc5f658 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6 [ 430.636283][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f965c6254f7 [ 430.644356][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fff4bc5f710 [ 430.652501][ T30] RBP: 00007fff4bc5f710 R08: 0000000000000000 R09: 0000000000000000 [ 430.660534][ T30] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007fff4bc60770 [ 430.668506][ T30] R13: 0000555584fff6c0 R14: 0000000000000001 R15: 431bde82d7b634db [ 430.676590][ T30] [ 430.679704][ T30] [ 430.679704][ T30] Showing all locks held in the system: [ 430.687452][ T30] 1 lock held by khungtaskd/30: [ 430.692382][ T30] #0: ffffffff8e937ae0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0 [ 430.702434][ T30] 5 locks held by kworker/u8:7/2993: [ 430.707754][ T30] 2 locks held by getty/5576: [ 430.712577][ T30] #0: ffff888031da60a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 430.722807][ T30] #1: ffffc9000332b2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x6a6/0x1e00 [ 430.733113][ T30] 1 lock held by syz-executor404/5849: [ 430.738739][ T30] #0: ffff88807aa100e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.749040][ T30] 2 locks held by syz-executor404/5850: [ 430.754688][ T30] #0: ffff8880223a40e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.765005][ T30] #1: ffffffff8ed53148 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.774097][ T30] 2 locks held by syz-executor404/5851: [ 430.779706][ T30] #0: ffff888076cac0e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.790123][ T30] #1: ffffffff8ed53148 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.799221][ T30] 2 locks held by syz-executor404/5852: [ 430.804785][ T30] #0: ffff88807b7920e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.815073][ T30] #1: ffffffff8ed53148 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.824189][ T30] 2 locks held by syz-executor404/5853: [ 430.829926][ T30] #0: ffff8880307340e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.840245][ T30] #1: ffffffff8ed53148 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.849340][ T30] [ 430.851672][ T30] ============================================= [ 430.851672][ T30] [ 430.860155][ T30] NMI backtrace for cpu 1 [ 430.864513][ T30] CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc7-syzkaller-00189-g595523945be0 #0 [ 430.875012][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 [ 430.885081][ T30] Call Trace: [ 430.888355][ T30] [ 430.891277][ T30] dump_stack_lvl+0x241/0x360 [ 430.895951][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 430.901144][ T30] ? __pfx__printk+0x10/0x10 [ 430.905761][ T30] nmi_cpu_backtrace+0x49c/0x4d0 [ 430.910740][ T30] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 430.916194][ T30] ? _printk+0xd5/0x120 [ 430.920344][ T30] ? __pfx__printk+0x10/0x10 [ 430.924930][ T30] ? __wake_up_klogd+0xcc/0x110 [ 430.929776][ T30] ? __pfx__printk+0x10/0x10 [ 430.934366][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 430.940342][ T30] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 430.946345][ T30] watchdog+0xff6/0x1040 [ 430.950596][ T30] ? watchdog+0x1ea/0x1040 [ 430.955012][ T30] ? __pfx_watchdog+0x10/0x10 [ 430.959754][ T30] kthread+0x2f0/0x390 [ 430.963857][ T30] ? __pfx_watchdog+0x10/0x10 [ 430.968594][ T30] ? __pfx_kthread+0x10/0x10 [ 430.973188][ T30] ret_from_fork+0x4b/0x80 [ 430.977597][ T30] ? __pfx_kthread+0x10/0x10 [ 430.982182][ T30] ret_from_fork_asm+0x1a/0x30 [ 430.986951][ T30] [ 430.990183][ T30] Sending NMI from CPU 1 to CPUs 0: [ 430.995737][ C0] NMI backtrace for cpu 0 [ 430.995752][ C0] CPU: 0 UID: 0 PID: 5183 Comm: klogd Not tainted 6.13.0-rc7-syzkaller-00189-g595523945be0 #0 [ 430.995770][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 [ 430.995780][ C0] RIP: 0010:__kasan_check_read+0x0/0x20 [ 430.995804][ C0] Code: 8e 4c 89 fe e8 e1 ae 03 ff 31 db eb d0 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 0f 1e fa 89 f6 48 8b 0c 24 31 d2 e9 6f e6 ff ff 66 2e 0f 1f 84 [ 430.995817][ C0] RSP: 0018:ffffc90003127448 EFLAGS: 00000003 [ 430.995832][ C0] RAX: 0000000000000002 RBX: 00000000000000a1 RCX: 0000000000040000 [ 430.995843][ C0] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff94271890 [ 430.995853][ C0] RBP: 00000000000400a1 R08: 0000000000000001 R09: 0000000000000000 [ 430.995863][ C0] R10: dffffc0000000000 R11: fffffbfff2030b4f R12: ffff88807b3b28c4 [ 430.995875][ C0] R13: 0000000000000000 R14: 00000000000000a1 R15: 0000000000000000 [ 430.995885][ C0] FS: 00007fcb5c70a380(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000 [ 430.995899][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 430.995910][ C0] CR2: 0000559f4382cd88 CR3: 000000007c776000 CR4: 00000000003526f0 [ 430.995924][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 430.995934][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 430.995943][ C0] Call Trace: [ 430.995949][ C0] [ 430.995955][ C0] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 430.995975][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 430.995993][ C0] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 430.996016][ C0] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 430.996038][ C0] ? nmi_handle+0x14f/0x5a0 [ 430.996055][ C0] ? nmi_handle+0x2a/0x5a0 [ 430.996080][ C0] ? __pfx___kasan_check_read+0x10/0x10 [ 430.996098][ C0] ? default_do_nmi+0x63/0x160 [ 430.996116][ C0] ? exc_nmi+0x123/0x1f0 [ 430.996132][ C0] ? end_repeat_nmi+0xf/0x53 [ 430.996152][ C0] ? __pfx___kasan_check_read+0x10/0x10 [ 430.996170][ C0] ? __pfx___kasan_check_read+0x10/0x10 [ 430.996188][ C0] ? __pfx___kasan_check_read+0x10/0x10 [ 430.996206][ C0] [ 430.996211][ C0] [ 430.996216][ C0] __lock_acquire+0x4ac/0x2100 [ 430.996234][ C0] ? kasan_save_track+0x51/0x80 [ 430.996253][ C0] ? __alloc_skb+0x1c3/0x440 [ 430.996268][ C0] ? alloc_skb_with_frags+0xc3/0x820 [ 430.996287][ C0] lock_acquire+0x1ed/0x550 [ 430.996302][ C0] ? __kmalloc_node_track_caller_noprof+0xad/0x4c0 [ 430.996322][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 430.996344][ C0] fs_reclaim_acquire+0x88/0x130 [ 430.996362][ C0] ? __kmalloc_node_track_caller_noprof+0xad/0x4c0 [ 430.996378][ C0] __kmalloc_node_track_caller_noprof+0xad/0x4c0 [ 430.996395][ C0] ? __alloc_skb+0x1f3/0x440 [ 430.996409][ C0] ? rcu_is_watching+0x15/0xb0 [ 430.996429][ C0] ? __alloc_skb+0x1f3/0x440 [ 430.996450][ C0] kmalloc_reserve+0x111/0x2a0 [ 430.996467][ C0] __alloc_skb+0x1f3/0x440 [ 430.996482][ C0] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.996511][ C0] ? __pfx___alloc_skb+0x10/0x10 [ 430.996533][ C0] alloc_skb_with_frags+0xc3/0x820 [ 430.996554][ C0] sock_alloc_send_pskb+0x91a/0xa60 [ 430.996579][ C0] ? __pfx_sock_alloc_send_pskb+0x10/0x10 [ 430.996600][ C0] ? do_raw_spin_unlock+0x13c/0x8b0 [ 430.996624][ C0] unix_dgram_sendmsg+0x6d3/0x1f80 [ 430.996646][ C0] ? __pfx_smack_socket_sendmsg+0x10/0x10 [ 430.996665][ C0] ? tomoyo_socket_sendmsg_permission+0x288/0x420 [ 430.996688][ C0] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 430.996711][ C0] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 430.996728][ C0] __sock_sendmsg+0x221/0x270 [ 430.996750][ C0] __sys_sendto+0x363/0x4c0 [ 430.996768][ C0] ? __pfx___sys_sendto+0x10/0x10 [ 430.996792][ C0] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 430.996809][ C0] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 430.996827][ C0] __x64_sys_sendto+0xde/0x100 [ 430.996844][ C0] do_syscall_64+0xf3/0x230 [ 430.996858][ C0] ? clear_bhb_loop+0x35/0x90 [ 430.996873][ C0] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.996896][ C0] RIP: 0033:0x7fcb5c86c9b5 [ 430.996908][ C0] Code: 8b 44 24 08 48 83 c4 28 48 98 c3 48 98 c3 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 26 45 31 c9 45 31 c0 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 76 7a 48 8b 15 44 c4 0c 00 f7 d8 64 89 02 48 83 [ 430.996921][ C0] RSP: 002b:00007ffc777da808 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 430.996936][ C0] RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007fcb5c86c9b5 [ 430.996947][ C0] RDX: 000000000000008b RSI: 000055f551e93a90 RDI: 0000000000000003 [ 430.996957][ C0] RBP: 000055f551e8f910 R08: 0000000000000000 R09: 0000000000000000 [ 430.996966][ C0] R10: 0000000000004000 R11: 0000000000000246 R12: 0000000000000013 [ 430.996976][ C0] R13: 00007fcb5c9fa212 R14: 00007ffc777da908 R15: 0000000000000000 [ 430.996992][ C0] [ 430.996999][ C0] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.262 msecs [ 430.997746][ T30] Kernel panic - not syncing: hung_task: blocked tasks [ 431.487736][ T30] CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc7-syzkaller-00189-g595523945be0 #0 [ 431.498247][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 [ 431.508320][ T30] Call Trace: [ 431.511621][ T30] [ 431.514564][ T30] dump_stack_lvl+0x241/0x360 [ 431.519254][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 431.524467][ T30] ? __pfx__printk+0x10/0x10 [ 431.529073][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 431.535070][ T30] ? vscnprintf+0x5d/0x90 [ 431.539404][ T30] panic+0x349/0x880 [ 431.543391][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 431.549549][ T30] ? __pfx_panic+0x10/0x10 [ 431.553974][ T30] ? tick_nohz_tick_stopped+0x82/0xb0 [ 431.559354][ T30] ? __irq_work_queue_local+0x137/0x410 [ 431.564933][ T30] ? irq_work_queue+0xca/0x150 [ 431.569702][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.575706][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.581691][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.587722][ T30] ? nmi_trigger_cpumask_backtrace+0x251/0x320 [ 431.593890][ T30] watchdog+0x1035/0x1040 [ 431.598233][ T30] ? watchdog+0x1ea/0x1040 [ 431.602654][ T30] ? __pfx_watchdog+0x10/0x10 [ 431.607356][ T30] kthread+0x2f0/0x390 [ 431.611429][ T30] ? __pfx_watchdog+0x10/0x10 [ 431.616211][ T30] ? __pfx_kthread+0x10/0x10 [ 431.620808][ T30] ret_from_fork+0x4b/0x80 [ 431.625221][ T30] ? __pfx_kthread+0x10/0x10 [ 431.629815][ T30] ret_from_fork_asm+0x1a/0x30 [ 431.634591][ T30] [ 431.637939][ T30] Kernel Offset: disabled [ 431.642285][ T30] Rebooting in 86400 seconds..