ci-upstream-kasan-gce-smack-root/strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ci-upstream-kasan-gce-smack-root/syz-executor2768265101 <...> Warning: Permanently added '10.128.1.34' (ED25519) to the list of known hosts. execve("ci-upstream-kasan-gce-smack-root/syz-executor2768265101", ["ci-upstream-kasan-gce-smack-root/syz-executor2768265101"], 0x7ffdbb15f810 /* 10 vars */) = 0 brk(NULL) = 0x555557b46000 brk(0x555557b46d80) = 0x555557b46d80 arch_prctl(ARCH_SET_FS, 0x555557b46400) = 0 set_tid_address(0x555557b466d0) = 5638 set_robust_list(0x555557b466e0, 24) = 0 rseq({cpu_id_start=0, cpu_id=RSEQ_CPU_ID_UNINITIALIZED, rseq_cs=NULL, flags=0, node_id=0, mm_cid=0, slice_ctrl={request=0, granted=0, __reserved=0}, __reserved=0}, 33, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlinkat(AT_FDCWD, "/proc/self/exe", "/root/ci-upstream-kasan-gce-smack-root/syz-executor2768265101", 4096) = 61 getrandom("\xa7\xc1\xd2\x75\x2e\x2d\xb1\x6a", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555557b46d80 brk(0x555557b67d80) = 0x555557b67d80 brk(0x555557b68000) = 0x555557b68000 mprotect(0x7fae06b1f000, 20480, PROT_READ) = 0 mmap(0x1ffffffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffffffff000 mmap(0x200000000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200000000000 mmap(0x200001000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200001000000 rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5639 attached , child_tidptr=0x555557b466d0) = 5639 [pid 5638] rt_sigprocmask(SIG_SETMASK, [] [pid 5639] set_robust_list(0x555557b466e0, 24) = 0 [pid 5638] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5638] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5639] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5638] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5639] getrandom( [pid 5638] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5639] <... getrandom resumed>"\xd9\xbe\xf2\x93\x0b\x66\x02\x39", 8, GRND_NONBLOCK) = 8 [pid 5639] mkdir("./syzkaller.nK9m8A", 0700ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5640 attached [pid 5638] <... clone resumed>, child_tidptr=0x555557b466d0) = 5640 [pid 5638] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5640] set_robust_list(0x555557b466e0, 24 [pid 5639] <... mkdir resumed>) = 0 [pid 5640] <... set_robust_list resumed>) = 0 [pid 5638] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5640] rt_sigprocmask(SIG_SETMASK, [] [pid 5639] chmod("./syzkaller.nK9m8A", 0777 [pid 5638] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5640] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5639] <... chmod resumed>) = 0 [pid 5640] getrandom( [pid 5639] chdir("./syzkaller.nK9m8A" [pid 5640] <... getrandom resumed>"\x35\x96\x9f\x53\xda\x9e\x1f\x37", 8, GRND_NONBLOCK) = 8 [pid 5639] <... chdir resumed>) = 0 [pid 5640] mkdir("./syzkaller.j8DsIL", 0700 [pid 5638] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5639] mkdir("./0", 0777 [pid 5640] <... mkdir resumed>) = 0 ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5641 attached [pid 5640] chmod("./syzkaller.j8DsIL", 0777 [pid 5638] <... clone resumed>, child_tidptr=0x555557b466d0) = 5641 [pid 5641] set_robust_list(0x555557b466e0, 24 [pid 5640] <... chmod resumed>) = 0 [pid 5638] rt_sigprocmask(SIG_SETMASK, [] [pid 5641] <... set_robust_list resumed>) = 0 [pid 5640] chdir("./syzkaller.j8DsIL" [pid 5638] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5641] rt_sigprocmask(SIG_SETMASK, [] [pid 5640] <... chdir resumed>) = 0 [pid 5638] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5641] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5640] mkdir("./0", 0777 [pid 5638] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5641] getrandom( [pid 5640] <... mkdir resumed>) = 0 [pid 5638] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5641] <... getrandom resumed>"\x32\x41\x26\xed\xef\x69\xd2\x5d", 8, GRND_NONBLOCK) = 8 [pid 5641] mkdir("./syzkaller.sEbbYK", 0700 [pid 5640] rt_sigprocmask(SIG_BLOCK, ~[]ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5642 attached [pid 5641] <... mkdir resumed>) = 0 [pid 5640] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5639] <... mkdir resumed>) = 0 [pid 5638] <... clone resumed>, child_tidptr=0x555557b466d0) = 5642 [pid 5641] chmod("./syzkaller.sEbbYK", 0777 [pid 5640] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5642] set_robust_list(0x555557b466e0, 24 [pid 5638] rt_sigprocmask(SIG_SETMASK, [] [pid 5641] <... chmod resumed>) = 0 [pid 5639] rt_sigprocmask(SIG_BLOCK, ~[]ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5643 attached [pid 5642] <... set_robust_list resumed>) = 0 [pid 5641] chdir("./syzkaller.sEbbYK" [pid 5638] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5643] set_robust_list(0x555557b466e0, 24 [pid 5641] <... chdir resumed>) = 0 [pid 5639] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5642] rt_sigprocmask(SIG_SETMASK, [] [pid 5640] <... clone resumed>, child_tidptr=0x555557b466d0) = 5643 [pid 5638] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5643] <... set_robust_list resumed>) = 0 [pid 5641] mkdir("./0", 0777 [pid 5639] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5638] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5643] rt_sigprocmask(SIG_SETMASK, [] [pid 5642] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5641] <... mkdir resumed>) = 0 [pid 5640] rt_sigprocmask(SIG_SETMASK, [] [pid 5643] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5642] getrandom( [pid 5643] chdir("./0" [pid 5641] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5640] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5643] <... chdir resumed>) = 0 [pid 5642] <... getrandom resumed>"\xed\xd3\xd4\xa7\x18\xea\xf7\xe7", 8, GRND_NONBLOCK) = 8 [pid 5641] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5643] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5642] mkdir("./syzkaller.NTy4Ex", 0700 [pid 5641] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5638] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5643] <... prctl resumed>) = 0 ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5645 attached ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5644 attached ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5646 attached [pid 5644] set_robust_list(0x555557b466e0, 24 [pid 5643] setpgid(0, 0 [pid 5642] <... mkdir resumed>) = 0 [pid 5646] set_robust_list(0x555557b466e0, 24 [pid 5645] set_robust_list(0x555557b466e0, 24 [pid 5644] <... set_robust_list resumed>) = 0 [pid 5643] <... setpgid resumed>) = 0 [pid 5639] <... clone resumed>, child_tidptr=0x555557b466d0) = 5644 [pid 5645] <... set_robust_list resumed>) = 0 [pid 5644] rt_sigprocmask(SIG_SETMASK, [] [pid 5641] <... clone resumed>, child_tidptr=0x555557b466d0) = 5646 [pid 5638] <... clone resumed>, child_tidptr=0x555557b466d0) = 5645 [pid 5646] <... set_robust_list resumed>) = 0 [pid 5645] rt_sigprocmask(SIG_SETMASK, [] [pid 5643] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5638] rt_sigprocmask(SIG_SETMASK, [] [pid 5646] rt_sigprocmask(SIG_SETMASK, [] [pid 5644] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5642] chmod("./syzkaller.NTy4Ex", 0777 [pid 5641] rt_sigprocmask(SIG_SETMASK, [] [pid 5639] rt_sigprocmask(SIG_SETMASK, [] [pid 5638] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5646] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5645] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5644] chdir("./0" [pid 5643] <... openat resumed>) = 3 [pid 5641] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5639] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5646] chdir("./0" [pid 5645] getrandom( [pid 5644] <... chdir resumed>) = 0 [pid 5642] <... chmod resumed>) = 0 [pid 5646] <... chdir resumed>) = 0 [pid 5645] <... getrandom resumed>"\x20\x53\x38\x50\x77\x11\xb1\x3b", 8, GRND_NONBLOCK) = 8 [pid 5644] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5643] write(3, "1000", 4 [pid 5646] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5645] mkdir("./syzkaller.2HjnTT", 0700 [pid 5644] <... prctl resumed>) = 0 [pid 5643] <... write resumed>) = 4 [pid 5642] chdir("./syzkaller.NTy4Ex" [pid 5646] <... prctl resumed>) = 0 [pid 5644] setpgid(0, 0 [pid 5643] close(3 [pid 5642] <... chdir resumed>) = 0 [pid 5646] setpgid(0, 0 [pid 5644] <... setpgid resumed>) = 0 [pid 5644] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5646] <... setpgid resumed>) = 0 [pid 5645] <... mkdir resumed>) = 0 [pid 5643] <... close resumed>) = 0 [pid 5642] mkdir("./0", 0777 [pid 5646] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5645] chmod("./syzkaller.2HjnTT", 0777 [pid 5644] <... openat resumed>) = 3 [pid 5643] symlink("/dev/binderfs", "./binderfs" [pid 5646] <... openat resumed>) = 3 [pid 5645] <... chmod resumed>) = 0 [pid 5644] write(3, "1000", 4 [pid 5642] <... mkdir resumed>) = 0 [pid 5642] rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 [pid 5642] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5646] write(3, "1000", 4 [pid 5645] chdir("./syzkaller.2HjnTT" [pid 5644] <... write resumed>) = 4 [pid 5643] <... symlink resumed>) = 0 [pid 5643] write(1, "executing program\n", 18 [pid 5646] <... write resumed>) = 4 [pid 5645] <... chdir resumed>) = 0 executing program [pid 5644] close(3ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5647 attached [pid 5646] close(3 [pid 5645] mkdir("./0", 0777 [pid 5644] <... close resumed>) = 0 [pid 5643] <... write resumed>) = 18 [pid 5646] <... close resumed>) = 0 [pid 5644] symlink("/dev/binderfs", "./binderfs" [pid 5643] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5645] <... mkdir resumed>) = 0 [pid 5643] <... mkdirat resumed>) = 0 [pid 5647] set_robust_list(0x555557b466e0, 24 [pid 5646] symlink("/dev/binderfs", "./binderfs" [pid 5644] <... symlink resumed>) = 0 [pid 5642] <... clone resumed>, child_tidptr=0x555557b466d0) = 5647 [pid 5645] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5647] <... set_robust_list resumed>) = 0 [pid 5645] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5647] rt_sigprocmask(SIG_SETMASK, [] [pid 5646] <... symlink resumed>) = 0 [pid 5645] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5644] write(1, "executing program\n", 18 [pid 5642] rt_sigprocmask(SIG_SETMASK, [] [pid 5647] <... rt_sigprocmask resumed>, NULL, 8) = 0 executing program [pid 5646] write(1, "executing program\n", 18 [pid 5644] <... write resumed>) = 18 [pid 5643] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5642] <... rt_sigprocmask resumed>, NULL, 8) = 0 executing program ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5648 attached [pid 5647] chdir("./0" [pid 5646] <... write resumed>) = 18 [pid 5644] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5647] <... chdir resumed>) = 0 [pid 5646] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5648] set_robust_list(0x555557b466e0, 24 [pid 5647] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5646] <... mkdirat resumed>) = 0 [pid 5645] <... clone resumed>, child_tidptr=0x555557b466d0) = 5648 [pid 5644] <... mkdirat resumed>) = 0 [pid 5648] <... set_robust_list resumed>) = 0 [pid 5647] <... prctl resumed>) = 0 [pid 5643] <... mount resumed>) = 0 [pid 5645] rt_sigprocmask(SIG_SETMASK, [] [pid 5647] setpgid(0, 0 [pid 5645] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5647] <... setpgid resumed>) = 0 [pid 5647] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5646] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5648] rt_sigprocmask(SIG_SETMASK, [] [pid 5643] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5648] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5647] <... openat resumed>) = 3 [pid 5646] <... mount resumed>) = 0 [pid 5647] write(3, "1000", 4 [pid 5643] <... openat resumed>) = 3 [pid 5647] <... write resumed>) = 4 [pid 5648] chdir("./0" [pid 5647] close(3 [pid 5644] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5648] <... chdir resumed>) = 0 [pid 5647] <... close resumed>) = 0 [pid 5646] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5647] symlink("/dev/binderfs", "./binderfs" [pid 5646] <... openat resumed>) = 3 [pid 5648] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5647] <... symlink resumed>) = 0 [pid 5646] write(3, "mem", 3 [pid 5644] <... mount resumed>) = 0 [pid 5643] write(3, "mem", 3 [pid 5648] <... prctl resumed>) = 0 [pid 5647] write(1, "executing program\n", 18 [pid 5648] setpgid(0, 0) = 0 executing program [pid 5644] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5643] <... write resumed>) = -1 EBUSY (Device or resource busy) [pid 5648] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5647] <... write resumed>) = 18 [pid 5644] <... openat resumed>) = 3 [pid 5643] mkdirat(AT_FDCWD, "./nfsd", 0777 [pid 5648] <... openat resumed>) = 3 [pid 5648] write(3, "1000", 4 [pid 5647] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5644] write(3, "mem", 3 [pid 5643] <... mkdirat resumed>) = 0 [pid 5648] <... write resumed>) = 4 [pid 5644] <... write resumed>) = -1 EBUSY (Device or resource busy) [pid 5648] close(3 [pid 5644] mkdirat(AT_FDCWD, "./nfsd", 0777 [pid 5643] mount(NULL, "./nfsd", "nfsd", 0, NULL [pid 5648] <... close resumed>) = 0 [pid 5648] symlink("/dev/binderfs", "./binderfs" [pid 5644] <... mkdirat resumed>) = 0 [pid 5644] mount(NULL, "./nfsd", "nfsd", 0, NULL [pid 5648] <... symlink resumed>) = 0 [pid 5647] <... mkdirat resumed>) = 0 [pid 5644] <... mount resumed>) = 0 [pid 5643] <... mount resumed>) = 0 [pid 5648] write(1, "executing program\n", 18 executing program [pid 5647] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5644] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR [pid 5643] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR [pid 5648] <... write resumed>) = 18 [pid 5647] <... mount resumed>) = 0 [ 159.804690][ T5646] PM: suspend entry (deep) [ 159.805693][ T5643] PM: suspend entry (deep) [ 159.805705][ T5643] PM: suspend exit [ 159.813929][ T5644] PM: suspend entry (deep) [ 159.813961][ T5644] PM: suspend exit [pid 5648] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5643] <... openat resumed>) = 4 [pid 5643] write(4, "tcp 2049\n", 9 [pid 5644] <... openat resumed>) = 4 [pid 5644] write(4, "tcp 2049\n", 9 [pid 5647] openat(AT_FDCWD, "./sys/power/state", O_RDWR) = 3 [pid 5647] write(3, "mem", 3) = -1 EBUSY (Device or resource busy) [pid 5648] <... mkdirat resumed>) = 0 [pid 5647] mkdirat(AT_FDCWD, "./nfsd", 0777) = 0 [pid 5648] mount(NULL, "./sys", "sysfs", 0, NULL) = 0 [pid 5647] mount(NULL, "./nfsd", "nfsd", 0, NULL) = 0 [pid 5648] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5647] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR [pid 5648] <... openat resumed>) = 3 [pid 5647] <... openat resumed>) = 4 [pid 5647] write(4, "tcp 2049\n", 9 [pid 5648] write(3, "mem", 3) = -1 EBUSY (Device or resource busy) [pid 5648] mkdirat(AT_FDCWD, "./nfsd", 0777) = 0 [pid 5648] mount(NULL, "./nfsd", "nfsd", 0, NULL) = 0 [pid 5648] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR) = 4 [ 159.893624][ T5647] PM: suspend entry (deep) [ 159.893641][ T5647] PM: suspend exit [ 159.923827][ T5648] PM: suspend entry (deep) [ 159.923841][ T5648] PM: suspend exit [pid 5648] write(4, "tcp 2049\n", 9 [pid 5643] <... write resumed>) = 9 [pid 5643] exit_group(0) = ? [pid 5648] <... write resumed>) = -1 EADDRINUSE (Address already in use) [pid 5644] <... write resumed>) = -1 EADDRINUSE (Address already in use) [pid 5643] +++ exited with 0 +++ [pid 5647] <... write resumed>) = -1 EADDRINUSE (Address already in use) [pid 5644] exit_group(0 [pid 5648] exit_group(0 [pid 5647] exit_group(0 [pid 5640] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5643, si_uid=0, si_status=0, si_utime=0, si_stime=15 /* 0.15 s */} --- [pid 5644] <... exit_group resumed>) = ? [pid 5648] <... exit_group resumed>) = ? [pid 5647] <... exit_group resumed>) = ? [pid 5640] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5640] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5644] +++ exited with 0 +++ [pid 5640] fstat(3 [pid 5647] +++ exited with 0 +++ [pid 5640] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5639] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5644, si_uid=0, si_status=0, si_utime=0, si_stime=1 /* 0.01 s */} --- [pid 5648] +++ exited with 0 +++ [pid 5645] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5648, si_uid=0, si_status=0, si_utime=0, si_stime=5 /* 0.05 s */} --- [pid 5642] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5647, si_uid=0, si_status=0, si_utime=0, si_stime=0} --- [pid 5639] restart_syscall(<... resuming interrupted rt_sigprocmask ...> [pid 5642] restart_syscall(<... resuming interrupted rt_sigprocmask ...> [pid 5640] getdents64(3 [pid 5639] <... restart_syscall resumed>) = 0 [pid 5642] <... restart_syscall resumed>) = 0 [pid 5640] <... getdents64 resumed>, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5645] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5640] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5645] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5642] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5639] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5645] <... openat resumed>) = 3 [pid 5642] <... openat resumed>) = 3 [pid 5639] <... openat resumed>) = 3 [pid 5645] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5645] getdents64(3 [pid 5642] fstat(3 [pid 5639] fstat(3 [pid 5642] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5639] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5645] <... getdents64 resumed>, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5642] getdents64(3 [pid 5639] getdents64(3 [pid 5645] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] <... getdents64 resumed>, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5642] <... getdents64 resumed>, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5639] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... umount2 resumed>) = 0 [pid 5642] <... umount2 resumed>) = 0 [pid 5639] <... umount2 resumed>) = 0 [pid 5645] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5645] newfstatat(AT_FDCWD, "./0/nfsd", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5645] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5645] openat(AT_FDCWD, "./0/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5642] newfstatat(AT_FDCWD, "./0/nfsd" [pid 5639] newfstatat(AT_FDCWD, "./0/nfsd" [pid 5645] <... openat resumed>) = 4 [pid 5642] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5645] fstat(4 [pid 5642] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5645] getdents64(4 [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] openat(AT_FDCWD, "./0/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5645] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5639] openat(AT_FDCWD, "./0/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5642] <... openat resumed>) = 4 [pid 5645] getdents64(4, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5645] close(4) = 0 [pid 5642] fstat(4 [pid 5639] <... openat resumed>) = 4 [pid 5645] rmdir("./0/nfsd" [pid 5642] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5642] getdents64(4 [pid 5639] fstat(4 [pid 5642] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5639] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [ 160.387835][ T5640] svc: failed to register nfsdv3 RPC service (errno 111). [ 160.407158][ T5640] svc: failed to register nfsaclv3 RPC service (errno 111). [ 160.407178][ T5640] failed to unregister tcp with rpcbind [ 160.410162][ T5640] svc: failed to register nfsdv3 RPC service (errno 97). [ 160.410181][ T5640] svc: failed to register nfsaclv3 RPC service (errno 97). [pid 5642] getdents64(4, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5639] getdents64(4 [pid 5642] close(4 [pid 5639] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5642] <... close resumed>) = 0 [pid 5639] getdents64(4 [pid 5642] rmdir("./0/nfsd" [pid 5639] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5639] close(4) = 0 [pid 5639] rmdir("./0/nfsd" [pid 5645] <... rmdir resumed>) = 0 [pid 5642] <... rmdir resumed>) = 0 [pid 5645] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] <... rmdir resumed>) = 0 [pid 5642] newfstatat(AT_FDCWD, "./0/binderfs" [pid 5639] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5639] newfstatat(AT_FDCWD, "./0/binderfs" [pid 5645] newfstatat(AT_FDCWD, "./0/binderfs" [pid 5642] <... newfstatat resumed>, {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] <... newfstatat resumed>, {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] unlink("./0/binderfs" [pid 5645] <... newfstatat resumed>, {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5642] unlink("./0/binderfs" [pid 5639] <... unlink resumed>) = 0 [pid 5639] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] <... unlink resumed>) = 0 [pid 5645] unlink("./0/binderfs") = 0 [ 160.410194][ T5640] failed to unregister tcp with rpcbind [pid 5642] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] <... umount2 resumed>) = 0 [pid 5639] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5639] newfstatat(AT_FDCWD, "./0/sys", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5639] openat(AT_FDCWD, "./0/sys", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5639] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5639] getdents64(4, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5645] <... umount2 resumed>) = 0 [pid 5642] <... umount2 resumed>) = 0 [pid 5639] getdents64(4 [pid 5645] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] close(4 [pid 5642] newfstatat(AT_FDCWD, "./0/sys" [pid 5639] <... close resumed>) = 0 [pid 5645] newfstatat(AT_FDCWD, "./0/sys" [pid 5642] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] rmdir("./0/sys" [pid 5645] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5642] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] <... rmdir resumed>) = 0 [pid 5645] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] openat(AT_FDCWD, "./0/sys", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5639] getdents64(3 [pid 5645] openat(AT_FDCWD, "./0/sys", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5642] <... openat resumed>) = 4 [pid 5639] <... getdents64 resumed>, 0x555557b477a0 /* 0 entries */, 32768) = 0 [pid 5645] fstat(4 [pid 5642] fstat(4 [pid 5645] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5642] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5645] getdents64(4, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5642] getdents64(4 [pid 5645] getdents64(4 [pid 5642] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5639] close(3 [pid 5645] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5642] getdents64(4 [pid 5645] close(4 [pid 5642] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5645] <... close resumed>) = 0 [pid 5639] <... close resumed>) = 0 [pid 5645] rmdir("./0/sys" [pid 5642] close(4 [pid 5639] rmdir("./0" [pid 5645] <... rmdir resumed>) = 0 [pid 5642] <... close resumed>) = 0 [pid 5639] <... rmdir resumed>) = 0 [pid 5645] getdents64(3 [pid 5642] rmdir("./0/sys" [pid 5645] <... getdents64 resumed>, 0x555557b477a0 /* 0 entries */, 32768) = 0 [pid 5642] <... rmdir resumed>) = 0 [pid 5640] <... umount2 resumed>) = 0 [pid 5639] mkdir("./1", 0777 [pid 5645] close(3) = 0 [pid 5645] rmdir("./0" [pid 5640] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] getdents64(3 [pid 5640] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] <... mkdir resumed>) = 0 [pid 5642] <... getdents64 resumed>, 0x555557b477a0 /* 0 entries */, 32768) = 0 [pid 5640] newfstatat(AT_FDCWD, "./0/nfsd" [pid 5639] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5640] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5642] close(3 [pid 5640] umount2("./0/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5653 attached [pid 5642] <... close resumed>) = 0 [pid 5640] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5653] set_robust_list(0x555557b466e0, 24) = 0 [pid 5640] openat(AT_FDCWD, "./0/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5642] rmdir("./0" [pid 5640] <... openat resumed>) = 4 [pid 5653] rt_sigprocmask(SIG_SETMASK, [] [pid 5640] fstat(4 [pid 5653] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5640] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5653] chdir("./1" [pid 5640] getdents64(4 [pid 5653] <... chdir resumed>) = 0 [pid 5645] <... rmdir resumed>) = 0 [pid 5640] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5639] <... clone resumed>, child_tidptr=0x555557b466d0) = 5653 [pid 5653] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5645] mkdir("./1", 0777 [pid 5640] getdents64(4 [pid 5639] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5653] setpgid(0, 0 [pid 5640] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5653] <... setpgid resumed>) = 0 [pid 5653] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5640] close(4) = 0 [pid 5653] <... openat resumed>) = 3 [pid 5640] rmdir("./0/nfsd" [pid 5653] write(3, "1000", 4) = 4 [pid 5645] <... mkdir resumed>) = 0 [pid 5653] close(3) = 0 [pid 5645] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5653] symlink("/dev/binderfs", "./binderfs" [pid 5645] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5645] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5654 attached [pid 5653] <... symlink resumed>) = 0 [pid 5645] <... clone resumed>, child_tidptr=0x555557b466d0) = 5654 [pid 5654] set_robust_list(0x555557b466e0, 24 [pid 5653] write(1, "executing program\n", 18 executing program [pid 5645] rt_sigprocmask(SIG_SETMASK, [] [pid 5642] <... rmdir resumed>) = 0 [pid 5640] <... rmdir resumed>) = 0 [pid 5654] <... set_robust_list resumed>) = 0 [pid 5653] <... write resumed>) = 18 [pid 5645] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5654] rt_sigprocmask(SIG_SETMASK, [] [pid 5653] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5640] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5654] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5653] <... mkdirat resumed>) = 0 [pid 5642] mkdir("./1", 0777 [pid 5640] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5654] chdir("./1" [pid 5653] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5640] newfstatat(AT_FDCWD, "./0/binderfs" [pid 5653] <... mount resumed>) = 0 [pid 5640] <... newfstatat resumed>, {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5654] <... chdir resumed>) = 0 [pid 5653] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5640] unlink("./0/binderfs" [pid 5654] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5640] <... unlink resumed>) = 0 [pid 5654] setpgid(0, 0 [pid 5653] <... openat resumed>) = 3 [pid 5654] <... setpgid resumed>) = 0 [pid 5640] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5654] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5653] write(3, "mem", 3) = -1 EBUSY (Device or resource busy) [pid 5653] mkdirat(AT_FDCWD, "./nfsd", 0777) = 0 [pid 5653] mount(NULL, "./nfsd", "nfsd", 0, NULL [pid 5654] <... openat resumed>) = 3 [pid 5642] <... mkdir resumed>) = 0 [pid 5642] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5654] write(3, "1000", 4) = 4 [pid 5654] close(3 [pid 5642] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5654] <... close resumed>) = 0 [pid 5642] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5654] symlink("/dev/binderfs", "./binderfs" [pid 5653] <... mount resumed>) = 0 ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5655 attached [pid 5654] <... symlink resumed>) = 0 [pid 5640] <... umount2 resumed>) = 0 [pid 5655] set_robust_list(0x555557b466e0, 24 [pid 5654] write(1, "executing program\n", 18 [pid 5653] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR [pid 5642] <... clone resumed>, child_tidptr=0x555557b466d0) = 5655 executing program [pid 5640] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5655] <... set_robust_list resumed>) = 0 [pid 5654] <... write resumed>) = 18 [pid 5653] <... openat resumed>) = 4 [pid 5642] rt_sigprocmask(SIG_SETMASK, [] [pid 5640] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5654] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5640] newfstatat(AT_FDCWD, "./0/sys" [pid 5655] rt_sigprocmask(SIG_SETMASK, [] [pid 5653] write(4, "tcp 2049\n", 9 [pid 5642] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5640] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5655] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5655] chdir("./1" [pid 5640] umount2("./0/sys", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5640] openat(AT_FDCWD, "./0/sys", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5655] <... chdir resumed>) = 0 [ 160.663874][ T5653] PM: suspend entry (deep) [ 160.663890][ T5653] PM: suspend exit [pid 5655] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5654] <... mkdirat resumed>) = 0 [pid 5640] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5655] <... prctl resumed>) = 0 [pid 5654] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5655] setpgid(0, 0 [pid 5640] getdents64(4 [pid 5655] <... setpgid resumed>) = 0 [pid 5655] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5654] <... mount resumed>) = 0 [pid 5655] <... openat resumed>) = 3 [pid 5655] write(3, "1000", 4) = 4 [pid 5655] close(3) = 0 [pid 5655] symlink("/dev/binderfs", "./binderfs" [pid 5654] openat(AT_FDCWD, "./sys/power/state", O_RDWR) = 3 [pid 5654] write(3, "mem", 3) = -1 EBUSY (Device or resource busy) [pid 5654] mkdirat(AT_FDCWD, "./nfsd", 0777 [pid 5655] <... symlink resumed>) = 0 [pid 5654] <... mkdirat resumed>) = 0 [pid 5640] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5655] write(1, "executing program\n", 18) = 18 [pid 5654] mount(NULL, "./nfsd", "nfsd", 0, NULL [pid 5655] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5654] <... mount resumed>) = 0 executing program [pid 5655] <... mkdirat resumed>) = 0 [pid 5654] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR [pid 5640] getdents64(4, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5640] close(4 [pid 5654] <... openat resumed>) = 4 [pid 5655] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5654] write(4, "tcp 2049\n", 9 [pid 5655] <... mount resumed>) = 0 [pid 5640] <... close resumed>) = 0 [pid 5655] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5640] rmdir("./0/sys" [pid 5655] <... openat resumed>) = 3 [pid 5640] <... rmdir resumed>) = 0 [pid 5655] write(3, "mem", 3) = -1 EBUSY (Device or resource busy) [pid 5655] mkdirat(AT_FDCWD, "./nfsd", 0777) = 0 [ 160.752180][ T5654] PM: suspend entry (deep) [ 160.752196][ T5654] PM: suspend exit [pid 5655] mount(NULL, "./nfsd", "nfsd", 0, NULL [pid 5640] getdents64(3, 0x555557b477a0 /* 0 entries */, 32768) = 0 [pid 5640] close(3) = 0 [pid 5640] rmdir("./0" [pid 5655] <... mount resumed>) = 0 [pid 5655] openat(AT_FDCWD, "./nfsd/portlist", O_RDWR) = 4 [ 160.798068][ T5655] PM: suspend entry (deep) [ 160.798085][ T5655] PM: suspend exit [pid 5655] write(4, "tcp 2049\n", 9) = -1 EADDRINUSE (Address already in use) [pid 5654] <... write resumed>) = -1 EADDRINUSE (Address already in use) [pid 5653] <... write resumed>) = 9 [pid 5655] exit_group(0 [pid 5654] exit_group(0 [pid 5653] exit_group(0 [pid 5655] <... exit_group resumed>) = ? [pid 5654] <... exit_group resumed>) = ? [pid 5653] <... exit_group resumed>) = ? [pid 5640] <... rmdir resumed>) = 0 [pid 5655] +++ exited with 0 +++ [pid 5653] +++ exited with 0 +++ [pid 5654] +++ exited with 0 +++ [pid 5640] mkdir("./1", 0777 [pid 5642] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5655, si_uid=0, si_status=0, si_utime=0, si_stime=0} --- [pid 5645] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5654, si_uid=0, si_status=0, si_utime=0, si_stime=0} --- [pid 5642] restart_syscall(<... resuming interrupted rt_sigprocmask ...> [pid 5639] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5653, si_uid=0, si_status=0, si_utime=0, si_stime=6 /* 0.06 s */} --- [pid 5645] restart_syscall(<... resuming interrupted rt_sigprocmask ...> [pid 5642] <... restart_syscall resumed>) = 0 [pid 5639] restart_syscall(<... resuming interrupted rt_sigprocmask ...>) = 0 [pid 5642] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5645] <... restart_syscall resumed>) = 0 [pid 5642] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5639] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5640] <... mkdir resumed>) = 0 [pid 5642] <... openat resumed>) = 3 [pid 5640] rt_sigprocmask(SIG_BLOCK, ~[] [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] fstat(3 [pid 5640] <... rt_sigprocmask resumed>, [], 8) = 0 [pid 5639] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5645] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5642] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5640] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5639] <... openat resumed>) = 3 [pid 5645] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5642] getdents64(3ci-upstream-kasan-gce-smack-root/strace-static-x86_64: Process 5656 attached , 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5639] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5645] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5642] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] getdents64(3, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5656] set_robust_list(0x555557b466e0, 24 [pid 5645] <... openat resumed>) = 3 [pid 5639] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5656] <... set_robust_list resumed>) = 0 [pid 5645] fstat(3 [pid 5640] <... clone resumed>, child_tidptr=0x555557b466d0) = 5656 [pid 5656] rt_sigprocmask(SIG_SETMASK, [] [pid 5645] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5640] rt_sigprocmask(SIG_SETMASK, [] [pid 5656] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5645] getdents64(3 [pid 5656] chdir("./1" [pid 5645] <... getdents64 resumed>, 0x555557b477a0 /* 5 entries */, 32768) = 128 [pid 5656] <... chdir resumed>) = 0 [pid 5645] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5640] <... rt_sigprocmask resumed>, NULL, 8) = 0 [pid 5656] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5656] setpgid(0, 0) = 0 [pid 5656] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5642] <... umount2 resumed>) = 0 [pid 5656] <... openat resumed>) = 3 [pid 5639] <... umount2 resumed>) = 0 [pid 5642] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5656] write(3, "1000", 4 [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5639] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5656] <... write resumed>) = 4 [pid 5642] newfstatat(AT_FDCWD, "./1/nfsd" [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5656] close(3) = 0 [pid 5642] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5639] newfstatat(AT_FDCWD, "./1/nfsd" [pid 5656] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5642] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5639] <... newfstatat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [ 160.918347][ T1446] Filesystems sync: 1.110 seconds [pid 5642] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5656] write(1, "executing program\n", 18 [pid 5639] umount2("./1/nfsd", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5656] <... write resumed>) = 18 executing program [pid 5642] openat(AT_FDCWD, "./1/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5639] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5656] mkdirat(AT_FDCWD, "./sys", 0777 [pid 5642] <... openat resumed>) = 4 [pid 5639] openat(AT_FDCWD, "./1/nfsd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5656] <... mkdirat resumed>) = 0 [pid 5642] fstat(4 [pid 5639] <... openat resumed>) = 4 [pid 5639] fstat(4 [pid 5656] mount(NULL, "./sys", "sysfs", 0, NULL [pid 5642] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5642] getdents64(4, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [pid 5639] <... fstat resumed>, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 5642] getdents64(4 [pid 5656] <... mount resumed>) = 0 [pid 5642] <... getdents64 resumed>, 0x555557b4f7e0 /* 0 entries */, 32768) = 0 [pid 5642] close(4 [pid 5639] getdents64(4 [pid 5642] <... close resumed>) = 0 [pid 5642] rmdir("./1/nfsd" [pid 5656] openat(AT_FDCWD, "./sys/power/state", O_RDWR [pid 5639] <... getdents64 resumed>, 0x555557b4f7e0 /* 2 entries */, 32768) = 48 [ 160.976092][ T5646] Freezing user space processes [ 161.003635][ T5645] svc: failed to register nfsdv3 RPC service (errno 111). [ 161.005067][ T5645] svc: failed to register nfsaclv3 RPC service (errno 111). [ 161.005087][ T5645] failed to unregister tcp with rpcbind [ 161.005333][ T5645] svc: failed to register nfsdv3 RPC servic[ 161.005333][ T5645] svc: failed to register nfsdv3 RPC service (errno 97). [ 161.005348][ T5645] svc: failed to register nfsaclv3 RPC service (errno 97). [ 161.005360][ T5645] failed to unregister tcp with rpcbind [ 161.029294][ T5646] ------------[ cut here ]------------ [ 161.029330][ T5646] debug_locks && p->lockdep_depth [ 161.029362][ T5646] WARNING: kernel/freezer.c:139 at __set_task_frozen+0x260/0x340, CPU#0: syz-executor276/5646 [ 161.029527][ T5646] Modules linked in: [ 161.029592][ T5646] CPU: 0 UID: 0 PID: 5646 Comm: syz-executor276 Not tainted syzkaller #0 PREEMPT_{RT,(full)} [ 161.029643][ T5646] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026 [ 161.029682][ T5646] RIP: 0010:__set_task_frozen+0x260/0x340 [ 161.029826][ T5646] Code: 00 80 00 00 89 e8 5b 41 5c 41 5d 41 5e 41 5f 5d e9 15 09 97 09 cc e8 ef 21 15 00 90 0f 0b 90 e9 f7 fe ff ff e8 e1 21 15 00 90 <0f> 0b 90 eb 93 44 89 e1 80 e1 07 80 c1 03 38 c1 0f 8c c3 fd ff ff [ 161.029869][ T5646] RSP: 0018:ffffc9000453f9f0 EFLAGS: 00010093 [ 161.029907][ T5646] RAX: ffffffff81b0b75f RBX: ffff888040865d00 RCX: ffff88801eaebe00 [ 161.029959][ T5646] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [ 161.029988][ T5646] RBP: 0000000000000002 R08: 0000000000000000 R09: 0000000000000000 [ 161.030004][ T5646] R10: dffffc0000000000 R11: ffffffff81b0b500 R12: ffff888040865d18 [ 161.030042][ T5646] R13: 1ffff1100810cba3 R14: 0000000000000000 R15: ffff888040866900 [ 161.030078][ T5646] FS: 0000555557b46400(0000) GS:ffff888125c3e000(0000) knlGS:0000000000000000 [ 161.030135][ T5646] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 161.030165][ T5646] CR2: 0000555557b577e8 CR3: 000000003c3b8000 CR4: 00000000003526f0 [ 161.030201][ T5646] Call Trace: [ 161.030221][ T5646] [ 161.030242][ T5646] ? __pfx___set_task_frozen+0x10/0x10 [ 161.030326][ T5646] task_call_func+0x1aa/0x260 [ 161.030423][ T5646] freeze_task+0x216/0x390 [ 161.030502][ T5646] ? __pfx_freeze_task+0x10/0x10 [ 161.030615][ T5646] try_to_freeze_tasks+0x190/0x620 [ 161.030703][ T5646] freeze_processes+0xce/0x1e0 [ 161.030750][ T5646] pm_suspend+0x2f1/0x760 [ 161.030778][ T5646] state_store+0x206/0x290 [ 161.030801][ T5646] ? __pfx_sysfs_kf_write+0x10/0x10 [ 161.030818][ T5646] kernfs_fop_write_iter+0x3a5/0x540 [ 161.030852][ T5646] vfs_write+0x61e/0xbb0 [ 161.030888][ T5646] ? __pfx_vfs_write+0x10/0x10 [ 161.030932][ T5646] ? rt_spin_unlock+0x157/0x200 [ 161.031023][ T5646] ? rt_spin_unlock+0x163/0x200 [ 161.031085][ T5646] ksys_write+0x156/0x270 [ 161.031174][ T5646] ? __pfx_ksys_write+0x10/0x10 [ 161.031274][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.031329][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.031381][ T5646] do_syscall_64+0x174/0x580 [ 161.031438][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.031490][ T5646] ? clear_bhb_loop+0x40/0x90 [ 161.031546][ T5646] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.031591][ T5646] RIP: 0033:0x7fae06a8bea9 [ 161.031641][ T5646] Code: c0 79 93 eb d5 48 8d 7c 1d 00 eb 99 0f 1f 44 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 d8 ff ff ff f7 d8 64 89 01 48 [ 161.031677][ T5646] RSP: 002b:00007ffcfa30da68 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 161.031723][ T5646] RAX: ffffffffffffffda RBX: 0000200000000000 RCX: 00007fae06a8bea9 [ 161.031752][ T5646] RDX: 0000000000000003 RSI: 0000200000000200 RDI: 0000000000000003 [ 161.031780][ T5646] RBP: 0000000000000000 R08: 000000000000000a R09: 000000000000000a [ 161.031807][ T5646] R10: 000000000000000a R11: 0000000000000246 R12: 00007ffcfa30dd78 [ 161.031851][ T5646] R13: 0000000000000002 R14: 0000200000000003 R15: 0000000000000000 [ 161.031929][ T5646] [ 161.031950][ T5646] Kernel panic - not syncing: kernel: panic_on_warn set ... [ 161.032011][ T5646] CPU: 0 UID: 0 PID: 5646 Comm: syz-executor276 Not tainted syzkaller #0 PREEMPT_{RT,(full)} [ 161.032069][ T5646] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026 [ 161.032105][ T5646] Call Trace: [ 161.032124][ T5646] [ 161.032144][ T5646] vpanic+0x56c/0xa60 [ 161.032194][ T5646] ? __pfx__printk+0x10/0x10 [ 161.032258][ T5646] ? __pfx_vpanic+0x10/0x10 [ 161.032286][ T5646] ? is_bpf_text_address+0x292/0x2b0 [ 161.032341][ T5646] ? is_bpf_text_address+0x26/0x2b0 [ 161.032376][ T5646] panic+0xc5/0xd0 [ 161.032419][ T5646] ? __pfx_panic+0x10/0x10 [ 161.032533][ T5646] __warn+0x315/0x4c0 [ 161.032597][ T5646] ? __set_task_frozen+0x260/0x340 [ 161.032689][ T5646] ? __set_task_frozen+0x260/0x340 [ 161.032766][ T5646] __report_bug+0x276/0x570 [ 161.032844][ T5646] ? __set_task_frozen+0x260/0x340 [ 161.032928][ T5646] ? __pfx___report_bug+0x10/0x10 [ 161.033003][ T5646] ? __lock_acquire+0x683/0x2ce0 [ 161.033069][ T5646] ? __lock_acquire+0x683/0x2ce0 [ 161.033146][ T5646] ? __set_task_frozen+0x260/0x340 [ 161.033220][ T5646] report_bug+0x16a/0x220 [ 161.033294][ T5646] ? __set_task_frozen+0x260/0x340 [ 161.033362][ T5646] ? __set_task_frozen+0x262/0x340 [ 161.033438][ T5646] handle_bug+0x9c/0x200 [ 161.033514][ T5646] exc_invalid_op+0x1a/0x50 [ 161.033594][ T5646] asm_exc_invalid_op+0x1a/0x20 [ 161.033634][ T5646] RIP: 0010:__set_task_frozen+0x260/0x340 [ 161.033724][ T5646] Code: 00 80 00 00 89 e8 5b 41 5c 41 5d 41 5e 41 5f 5d e9 15 09 97 09 cc e8 ef 21 15 00 90 0f 0b 90 e9 f7 fe ff ff e8 e1 21 15 00 90 <0f> 0b 90 eb 93 44 89 e1 80 e1 07 80 c1 03 38 c1 0f 8c c3 fd ff ff [ 161.033762][ T5646] RSP: 0018:ffffc9000453f9f0 EFLAGS: 00010093 [ 161.033789][ T5646] RAX: ffffffff81b0b75f RBX: ffff888040865d00 RCX: ffff88801eaebe00 [ 161.033811][ T5646] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [ 161.033829][ T5646] RBP: 0000000000000002 R08: 0000000000000000 R09: 0000000000000000 [ 161.033857][ T5646] R10: dffffc0000000000 R11: ffffffff81b0b500 R12: ffff888040865d18 [ 161.033912][ T5646] R13: 1ffff1100810cba3 R14: 0000000000000000 R15: ffff888040866900 [ 161.033975][ T5646] ? __pfx___set_task_frozen+0x10/0x10 [ 161.034068][ T5646] ? __set_task_frozen+0x25f/0x340 [ 161.034176][ T5646] ? __pfx___set_task_frozen+0x10/0x10 [ 161.034251][ T5646] task_call_func+0x1aa/0x260 [ 161.034345][ T5646] freeze_task+0x216/0x390 [ 161.034429][ T5646] ? __pfx_freeze_task+0x10/0x10 [ 161.034522][ T5646] try_to_freeze_tasks+0x190/0x620 [ 161.034612][ T5646] freeze_processes+0xce/0x1e0 [ 161.034680][ T5646] pm_suspend+0x2f1/0x760 [ 161.034736][ T5646] state_store+0x206/0x290 [ 161.034800][ T5646] ? __pfx_sysfs_kf_write+0x10/0x10 [ 161.034847][ T5646] kernfs_fop_write_iter+0x3a5/0x540 [ 161.034922][ T5646] vfs_write+0x61e/0xbb0 [ 161.035009][ T5646] ? __pfx_vfs_write+0x10/0x10 [ 161.035077][ T5646] ? rt_spin_unlock+0x157/0x200 [ 161.035151][ T5646] ? rt_spin_unlock+0x163/0x200 [ 161.035236][ T5646] ksys_write+0x156/0x270 [ 161.035305][ T5646] ? __pfx_ksys_write+0x10/0x10 [ 161.035412][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.035468][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.035525][ T5646] do_syscall_64+0x174/0x580 [ 161.035586][ T5646] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.035645][ T5646] ? clear_bhb_loop+0x40/0x90 [ 161.035709][ T5646] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 161.035784][ T5646] RIP: 0033:0x7fae06a8bea9 [ 161.035846][ T5646] Code: c0 79 93 eb d5 48 8d 7c 1d 00 eb 99 0f 1f 44 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 d8 ff ff ff f7 d8 64 89 01 48 [ 161.035897][ T5646] RSP: 002b:00007ffcfa30da68 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 161.035972][ T5646] RAX: ffffffffffffffda RBX: 0000200000000000 RCX: 00007fae06a8bea9 [ 161.036014][ T5646] RDX: 0000000000000003 RSI: 0000200000000200 RDI: 0000000000000003 [ 161.036054][ T5646] RBP: 0000000000000000 R08: 000000000000000a R09: 000000000000000a [ 161.036086][ T5646] R10: 000000000000000a R11: 0000000000000246 R12: 00007ffcfa30dd78 [ 161.036127][ T5646] R13: 0000000000000002 R14: 0000200000000003 R15: 0000000000000000 [ 161.036215][ T5646] [ 161.036818][ T5646] Kernel Offset: disabled